builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1450756736.45 results: success (0) buildid: 20151221173004 builduid: bdf4ecaafe9e45f0bb1bba276577c459 revision: 69b5cacf1cbbdb7f47dc775c17db96482d5123eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.447642) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.448083) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.448378) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006334 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.477643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.477914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.500174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.500439) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.549478) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.549766) ========= 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:56.550143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.550429) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 19:58:57-- 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% 226M=0s 2015-12-21 19:58:57 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122030 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.686770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.687053) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018228 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.740542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:56.740859) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 19:58:57,882 truncating revision to first 12 chars 2015-12-21 19:58:57,882 Setting DEBUG logging. 2015-12-21 19:58:57,882 attempt 1/10 2015-12-21 19:58:57,882 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:58,098 unpacking tar archive at: fx-team-69b5cacf1cbb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.471855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:57.225049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:57.225331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:57.234482) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:57.234833) ========= 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:57.235267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 19:58:57.235561) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:58 INFO - MultiFileLogger online at 20151221 19:58:58 in /builds/slave/test-pgo 19:58:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:58 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:58:58 INFO - {'append_to_log': False, 19:58:58 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:58:58 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:58:58 INFO - 'branch': 'Fx-Team', 19:58:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:58 INFO - 'config_files': ('talos/linux_config.py',), 19:58:58 INFO - 'default_actions': ('clobber', 19:58:58 INFO - 'read-buildbot-config', 19:58:58 INFO - 'download-and-extract', 19:58:58 INFO - 'populate-webroot', 19:58:58 INFO - 'create-virtualenv', 19:58:58 INFO - 'install', 19:58:58 INFO - 'run-tests'), 19:58:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:58 INFO - 'download_minidump_stackwalk': True, 19:58:58 INFO - 'download_symbols': 'ondemand', 19:58:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:58 INFO - 'installer_path': 'installer.exe', 19:58:58 INFO - 'log_level': 'info', 19:58:58 INFO - 'log_name': 'talos', 19:58:58 INFO - 'log_to_console': True, 19:58:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:58 INFO - 'opt_config_files': (), 19:58:58 INFO - 'pip_index': False, 19:58:58 INFO - 'sps_profile': False, 19:58:58 INFO - 'sps_profile_interval': 0, 19:58:58 INFO - 'suite': 'dromaeojs-e10s', 19:58:58 INFO - 'system_bits': '64', 19:58:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:58 INFO - 'title': 'talos-linux64-ix-020', 19:58:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:58 INFO - 'use_talos_json': True, 19:58:58 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:58:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:58 INFO - 'work_dir': 'build'} 19:58:58 INFO - ##### 19:58:58 INFO - ##### Running clobber step. 19:58:58 INFO - ##### 19:58:58 INFO - Running pre-action listener: _resource_record_pre_action 19:58:58 INFO - Running main action method: clobber 19:58:58 INFO - rmtree: /builds/slave/test-pgo/build 19:58:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:58:58 INFO - Running post-action listener: _resource_record_post_action 19:58:58 INFO - ##### 19:58:58 INFO - ##### Running read-buildbot-config step. 19:58:58 INFO - ##### 19:58:58 INFO - Running pre-action listener: _resource_record_pre_action 19:58:58 INFO - Running main action method: read_buildbot_config 19:58:58 INFO - Using buildbot properties: 19:58:58 INFO - { 19:58:58 INFO - "project": "", 19:58:58 INFO - "product": "firefox", 19:58:58 INFO - "script_repo_revision": "production", 19:58:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:58:58 INFO - "repository": "", 19:58:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:58:58 INFO - "buildid": "20151221173004", 19:58:58 INFO - "pgo_build": "True", 19:58:58 INFO - "basedir": "/builds/slave/test-pgo", 19:58:58 INFO - "buildnumber": 112, 19:58:58 INFO - "slavename": "talos-linux64-ix-020", 19:58:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:58:58 INFO - "platform": "ubuntu64_hw", 19:58:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:58 INFO - "branch": "fx-team", 19:58:58 INFO - "repo_path": "integration/fx-team", 19:58:58 INFO - "revision": "69b5cacf1cbbdb7f47dc775c17db96482d5123eb", 19:58:58 INFO - "stage_platform": "linux64-pgo", 19:58:58 INFO - "builduid": "bdf4ecaafe9e45f0bb1bba276577c459", 19:58:58 INFO - "slavebuilddir": "test" 19:58:58 INFO - } 19:58:58 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:58 INFO - Running post-action listener: _resource_record_post_action 19:58:58 INFO - ##### 19:58:58 INFO - ##### Running download-and-extract step. 19:58:58 INFO - ##### 19:58:58 INFO - Running pre-action listener: _resource_record_pre_action 19:58:58 INFO - Running main action method: download_and_extract 19:58:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:58 INFO - https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:58:58 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:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/test_packages.json 19:58:58 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:58 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:59 INFO - Downloaded 1302 bytes. 19:58:59 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:58:59 INFO - Using the following test package requirements: 19:58:59 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:59 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:59 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:59 INFO - u'jsshell-linux-x86_64.zip'], 19:58:59 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:59 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:59 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:59 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:59 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:59 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:59 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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 - 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:59 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:59 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:59 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:59 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:59:00 INFO - Downloaded 23175441 bytes. 19:59:00 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:59:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:00 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:59:02 INFO - Return code: 0 19:59:02 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: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 - 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:59:02 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:59:02 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:59:02 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:59:02 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:59:05 INFO - Downloaded 23175441 bytes. 19:59:05 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:59:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:05 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:59:07 INFO - Return code: 0 19:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:07 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:59:07 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:59:07 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:59:07 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:59:07 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:59:08 INFO - Downloaded 11132277 bytes. 19:59:08 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:59:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:08 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:59:08 INFO - Return code: 0 19:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:08 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:59:08 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:59:08 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:59:08 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:59:08 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:59:09 INFO - Downloaded 54880087 bytes. 19:59:09 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:59:09 INFO - mkdir: /builds/slave/test-pgo/properties 19:59:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:59:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:59:09 INFO - Contents: 19:59:09 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:59:09 INFO - Running post-action listener: _resource_record_post_action 19:59:09 INFO - Running post-action listener: set_extra_try_arguments 19:59:09 INFO - ##### 19:59:09 INFO - ##### Running populate-webroot step. 19:59:09 INFO - ##### 19:59:09 INFO - Running pre-action listener: _resource_record_pre_action 19:59:09 INFO - Running main action method: populate_webroot 19:59:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:09 INFO - '--tppagecycles', 19:59:09 INFO - '7'], 19:59:09 INFO - 'tests': ['tsvgm']}}, 19:59:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:59:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:09 INFO - 'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:09 INFO - 'tests': ['damp', 'tps']}, 19:59:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:09 INFO - 'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['damp', 'tps']}, 19:59:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:59:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:09 INFO - 'other': {'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore']}, 19:59:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore']}, 19:59:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore']}, 19:59:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore']}, 19:59:09 INFO - 'other_l64': {'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore']}, 19:59:09 INFO - 'other_nol64': {'tests': ['a11yr', 19:59:09 INFO - 'ts_paint', 19:59:09 INFO - 'tpaint', 19:59:09 INFO - 'sessionrestore', 19:59:09 INFO - 'sessionrestore_no_auto_restore']}, 19:59:09 INFO - 'svgr': {'tests': ['tsvgx', 19:59:09 INFO - 'tsvgr_opacity', 19:59:09 INFO - 'tart', 19:59:09 INFO - 'tscrollx', 19:59:09 INFO - 'cart']}, 19:59:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['tsvgx', 19:59:09 INFO - 'tsvgr_opacity', 19:59:09 INFO - 'tart', 19:59:09 INFO - 'tscrollx', 19:59:09 INFO - 'cart']}, 19:59:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:09 INFO - 'tests': ['tp5o']}, 19:59:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:09 INFO - 'talos_options': ['--e10s'], 19:59:09 INFO - 'tests': ['tp5o']}, 19:59:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:09 INFO - 'talos_options': ['--xperf_path', 19:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:09 INFO - 'tests': ['tp5n']}, 19:59:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:09 INFO - 'talos_options': ['--e10s', 19:59:09 INFO - '--xperf_path', 19:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:09 INFO - 'tests': ['tp5n']}}, 19:59:09 INFO - 'talos.zip': {'path': '', 19:59:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:09 INFO - Running post-action listener: _resource_record_post_action 19:59:09 INFO - ##### 19:59:09 INFO - ##### Running create-virtualenv step. 19:59:09 INFO - ##### 19:59:09 INFO - Running pre-action listener: _resource_record_pre_action 19:59:09 INFO - Running main action method: create_virtualenv 19:59:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:59:09 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:59:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:59:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:09 INFO - Using real prefix '/usr' 19:59:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:59:10 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:12 INFO - Installing pip.................done. 19:59:12 INFO - Return code: 0 19:59:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:59:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:12 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:59:12 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:59:12 INFO - Using env: {'DISPLAY': ':0', 19:59:12 INFO - 'HOME': '/home/cltbld', 19:59:12 INFO - 'LANG': 'en_US.UTF-8', 19:59:12 INFO - 'LANGUAGE': 'en_US:en', 19:59:12 INFO - 'LOGNAME': 'cltbld', 19:59:12 INFO - 'MAIL': '/var/mail/cltbld', 19:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:12 INFO - 'MOZ_NO_REMOTE': '1', 19:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:12 INFO - 'NO_EM_RESTART': '1', 19:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:12 INFO - 'SHELL': '/bin/bash', 19:59:12 INFO - 'SHLVL': '1', 19:59:12 INFO - 'TERM': 'linux', 19:59:12 INFO - 'TMOUT': '86400', 19:59:12 INFO - 'USER': 'cltbld', 19:59:12 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:12 INFO - '_': '/tools/buildbot/bin/python'} 19:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:12 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:59:12 INFO - Cleaning up... 19:59:12 INFO - Return code: 0 19:59:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:59:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:12 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:59:12 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:59:12 INFO - Using env: {'DISPLAY': ':0', 19:59:12 INFO - 'HOME': '/home/cltbld', 19:59:12 INFO - 'LANG': 'en_US.UTF-8', 19:59:12 INFO - 'LANGUAGE': 'en_US:en', 19:59:12 INFO - 'LOGNAME': 'cltbld', 19:59:12 INFO - 'MAIL': '/var/mail/cltbld', 19:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:12 INFO - 'MOZ_NO_REMOTE': '1', 19:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:12 INFO - 'NO_EM_RESTART': '1', 19:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:12 INFO - 'SHELL': '/bin/bash', 19:59:12 INFO - 'SHLVL': '1', 19:59:12 INFO - 'TERM': 'linux', 19:59:12 INFO - 'TMOUT': '86400', 19:59:12 INFO - 'USER': 'cltbld', 19:59:12 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:12 INFO - '_': '/tools/buildbot/bin/python'} 19:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:13 INFO - Downloading/unpacking psutil>=0.7.1 19:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:14 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:14 INFO - Installing collected packages: psutil 19:59:14 INFO - Running setup.py install for psutil 19:59:14 INFO - building 'psutil._psutil_linux' extension 19:59:14 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:59:15 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:59:15 INFO - building 'psutil._psutil_posix' extension 19:59:15 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:59:15 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:59:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:15 INFO - Successfully installed psutil 19:59:15 INFO - Cleaning up... 19:59:15 INFO - Return code: 0 19:59:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:59:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:15 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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:15 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:59:15 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:59:15 INFO - Using env: {'DISPLAY': ':0', 19:59:15 INFO - 'HOME': '/home/cltbld', 19:59:15 INFO - 'LANG': 'en_US.UTF-8', 19:59:15 INFO - 'LANGUAGE': 'en_US:en', 19:59:15 INFO - 'LOGNAME': 'cltbld', 19:59:15 INFO - 'MAIL': '/var/mail/cltbld', 19:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:15 INFO - 'MOZ_NO_REMOTE': '1', 19:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:15 INFO - 'NO_EM_RESTART': '1', 19:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:15 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:15 INFO - 'SHELL': '/bin/bash', 19:59:15 INFO - 'SHLVL': '1', 19:59:15 INFO - 'TERM': 'linux', 19:59:15 INFO - 'TMOUT': '86400', 19:59:15 INFO - 'USER': 'cltbld', 19:59:15 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:15 INFO - '_': '/tools/buildbot/bin/python'} 19:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:17 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:59:17 INFO - Installing collected packages: mozsystemmonitor 19:59:17 INFO - Running setup.py install for mozsystemmonitor 19:59:17 INFO - Successfully installed mozsystemmonitor 19:59:17 INFO - Cleaning up... 19:59:17 INFO - Return code: 0 19:59:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:59:17 INFO - Using env: {'DISPLAY': ':0', 19:59:17 INFO - 'HOME': '/home/cltbld', 19:59:17 INFO - 'LANG': 'en_US.UTF-8', 19:59:17 INFO - 'LANGUAGE': 'en_US:en', 19:59:17 INFO - 'LOGNAME': 'cltbld', 19:59:17 INFO - 'MAIL': '/var/mail/cltbld', 19:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:17 INFO - 'MOZ_NO_REMOTE': '1', 19:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:17 INFO - 'NO_EM_RESTART': '1', 19:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:17 INFO - 'SHELL': '/bin/bash', 19:59:17 INFO - 'SHLVL': '1', 19:59:17 INFO - 'TERM': 'linux', 19:59:17 INFO - 'TMOUT': '86400', 19:59:17 INFO - 'USER': 'cltbld', 19:59:17 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:17 INFO - '_': '/tools/buildbot/bin/python'} 19:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:17 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:19 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:59:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:59:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:59:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:20 INFO - Downloading docopt-0.6.1.tar.gz 19:59:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:59:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:20 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:20 INFO - Running setup.py install for blobuploader 19:59:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:20 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:59:20 INFO - Running setup.py install for requests 19:59:20 INFO - Running setup.py install for docopt 19:59:20 INFO - Successfully installed blobuploader requests docopt 19:59:20 INFO - Cleaning up... 19:59:20 INFO - Return code: 0 19:59:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:20 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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:20 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:59:20 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:59:20 INFO - Using env: {'DISPLAY': ':0', 19:59:20 INFO - 'HOME': '/home/cltbld', 19:59:20 INFO - 'LANG': 'en_US.UTF-8', 19:59:20 INFO - 'LANGUAGE': 'en_US:en', 19:59:20 INFO - 'LOGNAME': 'cltbld', 19:59:20 INFO - 'MAIL': '/var/mail/cltbld', 19:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:20 INFO - 'MOZ_NO_REMOTE': '1', 19:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:20 INFO - 'NO_EM_RESTART': '1', 19:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:20 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:20 INFO - 'SHELL': '/bin/bash', 19:59:20 INFO - 'SHLVL': '1', 19:59:20 INFO - 'TERM': 'linux', 19:59:20 INFO - 'TMOUT': '86400', 19:59:20 INFO - 'USER': 'cltbld', 19:59:20 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:20 INFO - '_': '/tools/buildbot/bin/python'} 19:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:21 INFO - Running setup.py (path:/tmp/pip-xIE99F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:21 INFO - Running setup.py (path:/tmp/pip-IDoCdq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:21 INFO - Running setup.py (path:/tmp/pip-AxomZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:21 INFO - Running setup.py (path:/tmp/pip-xZAEWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:21 INFO - Running setup.py (path:/tmp/pip-KPjFTe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:21 INFO - Running setup.py (path:/tmp/pip-Oho4OJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:21 INFO - Running setup.py (path:/tmp/pip-GTdtBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:21 INFO - Running setup.py (path:/tmp/pip-Q_GTA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:21 INFO - Running setup.py (path:/tmp/pip-aP6EJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:21 INFO - Running setup.py (path:/tmp/pip-iwnv08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:21 INFO - Running setup.py (path:/tmp/pip-M7E_lT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:21 INFO - Running setup.py (path:/tmp/pip-UVk86Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:21 INFO - Running setup.py (path:/tmp/pip-NOdIrs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:21 INFO - Running setup.py (path:/tmp/pip-whMk4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:22 INFO - Running setup.py (path:/tmp/pip-Ej14X_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:22 INFO - Running setup.py (path:/tmp/pip-v7YSO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:22 INFO - Running setup.py (path:/tmp/pip-vRreK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:22 INFO - Running setup.py install for manifestparser 19:59:22 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:59:22 INFO - Running setup.py install for mozcrash 19:59:22 INFO - Running setup.py install for mozdebug 19:59:22 INFO - Running setup.py install for mozdevice 19:59:22 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:59:22 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:59:22 INFO - Running setup.py install for mozfile 19:59:22 INFO - Running setup.py install for mozhttpd 19:59:22 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:59:22 INFO - Running setup.py install for mozinfo 19:59:22 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:59:22 INFO - Running setup.py install for mozInstall 19:59:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Running setup.py install for mozleak 19:59:23 INFO - Running setup.py install for mozlog 19:59:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Running setup.py install for moznetwork 19:59:23 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Running setup.py install for mozprocess 19:59:23 INFO - Running setup.py install for mozprofile 19:59:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Running setup.py install for mozrunner 19:59:23 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Running setup.py install for mozscreenshot 19:59:23 INFO - Running setup.py install for moztest 19:59:23 INFO - Running setup.py install for mozversion 19:59:23 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:59:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:23 INFO - Cleaning up... 19:59:24 INFO - Return code: 0 19:59:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:24 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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:24 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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:24 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:59:24 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:59:24 INFO - Using env: {'DISPLAY': ':0', 19:59:24 INFO - 'HOME': '/home/cltbld', 19:59:24 INFO - 'LANG': 'en_US.UTF-8', 19:59:24 INFO - 'LANGUAGE': 'en_US:en', 19:59:24 INFO - 'LOGNAME': 'cltbld', 19:59:24 INFO - 'MAIL': '/var/mail/cltbld', 19:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:24 INFO - 'MOZ_NO_REMOTE': '1', 19:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:24 INFO - 'NO_EM_RESTART': '1', 19:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:24 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:24 INFO - 'SHELL': '/bin/bash', 19:59:24 INFO - 'SHLVL': '1', 19:59:24 INFO - 'TERM': 'linux', 19:59:24 INFO - 'TMOUT': '86400', 19:59:24 INFO - 'USER': 'cltbld', 19:59:24 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:24 INFO - '_': '/tools/buildbot/bin/python'} 19:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:24 INFO - Running setup.py (path:/tmp/pip-nZMWww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:24 INFO - Running setup.py (path:/tmp/pip-JhfzRu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:24 INFO - Running setup.py (path:/tmp/pip-WC40tz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:24 INFO - Running setup.py (path:/tmp/pip-baVzRi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:24 INFO - Running setup.py (path:/tmp/pip-78_7Pq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:24 INFO - Running setup.py (path:/tmp/pip-LNKc67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:24 INFO - Running setup.py (path:/tmp/pip-RS80qc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:24 INFO - Running setup.py (path:/tmp/pip-pPj2eI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:24 INFO - Running setup.py (path:/tmp/pip-tVAxiP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:24 INFO - Running setup.py (path:/tmp/pip-Gp0r5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:24 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:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:24 INFO - Running setup.py (path:/tmp/pip-QYlbx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:25 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:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:25 INFO - Running setup.py (path:/tmp/pip-zJnbDv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:25 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:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:25 INFO - Running setup.py (path:/tmp/pip-wRm49f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:25 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:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:25 INFO - Running setup.py (path:/tmp/pip-1p67aG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:25 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:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:25 INFO - Running setup.py (path:/tmp/pip-u7VsbL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:25 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:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:25 INFO - Running setup.py (path:/tmp/pip-uLL1si-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:25 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:59:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:25 INFO - Running setup.py (path:/tmp/pip-bJyyXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:25 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:59:25 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:59:25 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:59:25 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:59:25 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:59:25 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:59:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:25 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:25 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:25 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:25 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:25 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:25 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:27 INFO - Downloading blessings-1.5.1.tar.gz 19:59:27 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:59:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:27 INFO - Installing collected packages: blessings 19:59:27 INFO - Running setup.py install for blessings 19:59:27 INFO - Successfully installed blessings 19:59:27 INFO - Cleaning up... 19:59:27 INFO - Return code: 0 19:59:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:59:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:27 INFO - Reading from file tmpfile_stdout 19:59:27 INFO - Current package versions: 19:59:27 INFO - argparse == 1.2.1 19:59:27 INFO - blessings == 1.5.1 19:59:27 INFO - blobuploader == 1.2.4 19:59:27 INFO - docopt == 0.6.1 19:59:27 INFO - manifestparser == 1.1 19:59:27 INFO - mozInstall == 1.12 19:59:27 INFO - mozcrash == 0.16 19:59:27 INFO - mozdebug == 0.1 19:59:27 INFO - mozdevice == 0.47 19:59:27 INFO - mozfile == 1.2 19:59:27 INFO - mozhttpd == 0.7 19:59:27 INFO - mozinfo == 0.9 19:59:27 INFO - mozleak == 0.1 19:59:27 INFO - mozlog == 3.1 19:59:27 INFO - moznetwork == 0.27 19:59:27 INFO - mozprocess == 0.22 19:59:27 INFO - mozprofile == 0.28 19:59:27 INFO - mozrunner == 6.11 19:59:27 INFO - mozscreenshot == 0.1 19:59:27 INFO - mozsystemmonitor == 0.0 19:59:27 INFO - moztest == 0.7 19:59:27 INFO - mozversion == 1.4 19:59:27 INFO - psutil == 3.1.1 19:59:27 INFO - requests == 1.2.3 19:59:27 INFO - wsgiref == 0.1.2 19:59:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:27 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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:27 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:59:27 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:59:27 INFO - Using env: {'DISPLAY': ':0', 19:59:27 INFO - 'HOME': '/home/cltbld', 19:59:27 INFO - 'LANG': 'en_US.UTF-8', 19:59:27 INFO - 'LANGUAGE': 'en_US:en', 19:59:27 INFO - 'LOGNAME': 'cltbld', 19:59:27 INFO - 'MAIL': '/var/mail/cltbld', 19:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:27 INFO - 'MOZ_NO_REMOTE': '1', 19:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:27 INFO - 'NO_EM_RESTART': '1', 19:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:27 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:27 INFO - 'SHELL': '/bin/bash', 19:59:27 INFO - 'SHLVL': '1', 19:59:27 INFO - 'TERM': 'linux', 19:59:27 INFO - 'TMOUT': '86400', 19:59:27 INFO - 'USER': 'cltbld', 19:59:27 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:27 INFO - '_': '/tools/buildbot/bin/python'} 19:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 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:59:27 INFO - Cleaning up... 19:59:27 INFO - Return code: 0 19:59:27 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:27 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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:27 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:59:27 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:59:27 INFO - Using env: {'DISPLAY': ':0', 19:59:27 INFO - 'HOME': '/home/cltbld', 19:59:27 INFO - 'LANG': 'en_US.UTF-8', 19:59:27 INFO - 'LANGUAGE': 'en_US:en', 19:59:27 INFO - 'LOGNAME': 'cltbld', 19:59:27 INFO - 'MAIL': '/var/mail/cltbld', 19:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:27 INFO - 'MOZ_NO_REMOTE': '1', 19:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:27 INFO - 'NO_EM_RESTART': '1', 19:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:27 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:27 INFO - 'SHELL': '/bin/bash', 19:59:27 INFO - 'SHLVL': '1', 19:59:27 INFO - 'TERM': 'linux', 19:59:27 INFO - 'TMOUT': '86400', 19:59:27 INFO - 'USER': 'cltbld', 19:59:27 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:27 INFO - '_': '/tools/buildbot/bin/python'} 19:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:28 INFO - Downloading/unpacking jsonschema 19:59:28 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:28 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:28 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:28 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:28 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:28 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:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:29 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:29 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:29 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:29 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:29 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:29 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:29 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:29 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:29 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:29 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:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:29 INFO - warning: no files found matching '*.txt' 19:59:29 INFO - no previously-included directories found matching 'build' 19:59:29 INFO - no previously-included directories found matching 'dist' 19:59:29 INFO - no previously-included directories found matching '.git*' 19:59:29 INFO - Installing collected packages: jsonschema, functools32 19:59:30 INFO - Running setup.py install for functools32 19:59:30 INFO - warning: no files found matching '*.txt' 19:59:30 INFO - no previously-included directories found matching 'build' 19:59:30 INFO - no previously-included directories found matching 'dist' 19:59:30 INFO - no previously-included directories found matching '.git*' 19:59:30 INFO - Successfully installed jsonschema functools32 19:59:30 INFO - Cleaning up... 19:59:30 INFO - Return code: 0 19:59:30 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:30 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 0x7f80332a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, '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': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 19:59:30 INFO - 'HOME': '/home/cltbld', 19:59:30 INFO - 'LANG': 'en_US.UTF-8', 19:59:30 INFO - 'LANGUAGE': 'en_US:en', 19:59:30 INFO - 'LOGNAME': 'cltbld', 19:59:30 INFO - 'MAIL': '/var/mail/cltbld', 19:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:30 INFO - 'MOZ_NO_REMOTE': '1', 19:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:30 INFO - 'NO_EM_RESTART': '1', 19:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:30 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:30 INFO - 'SHELL': '/bin/bash', 19:59:30 INFO - 'SHLVL': '1', 19:59:30 INFO - 'TERM': 'linux', 19:59:30 INFO - 'TMOUT': '86400', 19:59:30 INFO - 'USER': 'cltbld', 19:59:30 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:30 INFO - '_': '/tools/buildbot/bin/python'} 19:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:30 INFO - Downloading/unpacking flake8 19:59:30 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:30 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:30 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:30 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:30 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:30 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:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:32 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:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:32 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:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59:32 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:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:32 INFO - no previously-included directories found matching 'docs/_build' 19:59:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:32 INFO - Running setup.py install for pep8 19:59:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:32 INFO - no previously-included directories found matching 'docs/_build' 19:59:32 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:59:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:32 INFO - Cleaning up... 19:59:32 INFO - Return code: 0 19:59:32 INFO - Running post-action listener: _resource_record_post_action 19:59:32 INFO - Running post-action listener: _start_resource_monitoring 19:59:32 INFO - Starting resource monitoring. 19:59:32 INFO - ##### 19:59:32 INFO - ##### Running install step. 19:59:32 INFO - ##### 19:59:32 INFO - Running pre-action listener: _resource_record_pre_action 19:59:32 INFO - Running main action method: install 19:59:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:33 INFO - Reading from file tmpfile_stdout 19:59:33 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:59:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:59:33 INFO - Reading from file tmpfile_stdout 19:59:33 INFO - Output received: 19:59:33 INFO - Usage: mozinstall [options] installer 19:59:33 INFO - Options: 19:59:33 INFO - -h, --help show this help message and exit 19:59:33 INFO - -d DEST, --destination=DEST 19:59:33 INFO - Directory to install application into. [default: 19:59:33 INFO - "/builds/slave/test-pgo"] 19:59:33 INFO - --app=APP Application being installed. [default: firefox] 19:59:33 INFO - mkdir: /builds/slave/test-pgo/build/application 19:59:33 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:33 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:49 INFO - Reading from file tmpfile_stdout 19:59:49 INFO - Output received: 19:59:49 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:59:49 INFO - Running post-action listener: _resource_record_post_action 19:59:49 INFO - ##### 19:59:49 INFO - ##### Running run-tests step. 19:59:49 INFO - ##### 19:59:49 INFO - Running pre-action listener: _resource_record_pre_action 19:59:49 INFO - Running main action method: run_tests 19:59:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:59:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:59:49 INFO - Python 2.7.3 19:59:49 INFO - Return code: 0 19:59:49 INFO - grabbing minidump binary from tooltool 19:59: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:59:49 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 0x1f2b840>, '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 0x1e986b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e98b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:59:49 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:49 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:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:49 INFO - Return code: 0 19:59:49 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:59:49 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:59:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:59:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:59:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:59:50 INFO - Return code: 0 19:59:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:59:50 INFO - Using env: {'DISPLAY': ':0', 19:59:50 INFO - 'HOME': '/home/cltbld', 19:59:50 INFO - 'LANG': 'en_US.UTF-8', 19:59:50 INFO - 'LANGUAGE': 'en_US:en', 19:59:50 INFO - 'LOGNAME': 'cltbld', 19:59:50 INFO - 'MAIL': '/var/mail/cltbld', 19:59:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:50 INFO - 'MOZ_NO_REMOTE': '1', 19:59:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:50 INFO - 'NO_EM_RESTART': '1', 19:59:50 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:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:50 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:59:50 INFO - 'SHELL': '/bin/bash', 19:59:50 INFO - 'SHLVL': '1', 19:59:50 INFO - 'TERM': 'linux', 19:59:50 INFO - 'TMOUT': '86400', 19:59:50 INFO - 'USER': 'cltbld', 19:59:50 INFO - 'XDG_SESSION_COOKIE': 'fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739', 19:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:50 INFO - '_': '/tools/buildbot/bin/python'} 19:59:50 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:59:51 INFO - mozversion application_buildid: 20151221173004 19:59:51 INFO - mozversion application_changeset: 69b5cacf1cbbdb7f47dc775c17db96482d5123eb 19:59:51 INFO - mozversion application_display_name: Nightly 19:59:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:51 INFO - mozversion application_name: Firefox 19:59:51 INFO - mozversion application_remotingname: firefox 19:59:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:59:51 INFO - mozversion application_vendor: Mozilla 19:59:51 INFO - mozversion application_version: 46.0a1 19:59:51 INFO - mozversion platform_buildid: 20151221173004 19:59:51 INFO - mozversion platform_changeset: 69b5cacf1cbbdb7f47dc775c17db96482d5123eb 19:59:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:51 INFO - mozversion platform_version: 46.0a1 19:59:51 INFO - using testdate: 1450756791 19:59:51 INFO - actual date: 1450756791 19:59:51 INFO - starting webserver on 'localhost:36972' 19:59:51 INFO - SUITE-START | Running 3 tests 19:59:51 INFO - TEST-START | dromaeo_css 19:59:51 INFO - operating with platform_type : linux_ 19:59:51 INFO - Initialising browser for dromaeo_css test... 19:59:51 INFO - TEST-INFO | started process 6786 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZCsc0H/profile http://localhost:36972/getInfo.html) 19:59:55 INFO - PROCESS | 6786 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 19:59:56 INFO - PROCESS | 6786 | __metrics Screen width/height:1600/1200 19:59:56 INFO - PROCESS | 6786 | colorDepth:24 19:59:56 INFO - PROCESS | 6786 | Browser inner width/height: 1024/697 19:59:56 INFO - PROCESS | 6786 | __metrics 19:59:56 INFO - PROCESS | 6786 | 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:57 INFO - TEST-INFO | 6786: exit 0 19:59:57 INFO - Browser initialized. 19:59:57 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:57 INFO - TEST-INFO | started process 6918 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZCsc0H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:09 INFO - PROCESS | 6918 | RSS: Main: 150773760 20:00:09 INFO - PROCESS | 6918 | 20:00:58 INFO - PROCESS | 6918 | 1450756858663 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:03:07 INFO - PROCESS | 6918 | Cycle 1(1): loaded http://localhost:36972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36972/tests/dromaeo/cssquery-ext.html) 20:03:09 INFO - PROCESS | 6918 | RSS: Main: 157437952 20:03:09 INFO - PROCESS | 6918 | 20:06:11 INFO - PROCESS | 6918 | Cycle 1(1): loaded http://localhost:36972/tests/dromaeo/cssquery-ext.html (next: http://localhost:36972/tests/dromaeo/cssquery-jquery.html) 20:06:11 INFO - PROCESS | 6918 | RSS: Main: 154394624 20:06:11 INFO - PROCESS | 6918 | 20:09:13 INFO - PROCESS | 6918 | Cycle 1(1): loaded http://localhost:36972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36972/tests/dromaeo/cssquery-mootools.html) 20:09:13 INFO - PROCESS | 6918 | RSS: Main: 154697728 20:09:13 INFO - PROCESS | 6918 | 20:12:15 INFO - PROCESS | 6918 | Cycle 1(1): loaded http://localhost:36972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36972/tests/dromaeo/cssquery-prototype.html) 20:12:16 INFO - PROCESS | 6918 | RSS: Main: 152903680 20:12:16 INFO - PROCESS | 6918 | 20:15:18 INFO - PROCESS | 6918 | Cycle 1(1): loaded http://localhost:36972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36972/tests/dromaeo/cssquery-yui.html) 20:15:19 INFO - PROCESS | 6918 | RSS: Main: 152956928 20:15:19 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | Cycle 1(1): loaded http://localhost:36972/tests/dromaeo/cssquery-yui.html (next: http://localhost:36972/tests/dromaeo/cssquery-dojo.html) 20:18:21 INFO - PROCESS | 6918 | RSS: Main: 155656192 20:18:21 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | __start_tp_report 20:18:21 INFO - PROCESS | 6918 | _x_x_mozilla_page_load 20:18:21 INFO - PROCESS | 6918 | _x_x_mozilla_page_load_details 20:18:21 INFO - PROCESS | 6918 | |i|pagename|runs| 20:18:21 INFO - PROCESS | 6918 | |0;dojo.html;3199.824009679468;3268.0522648431956;3288.2765791525885;3312.039508542523;3318.518814771858;5263.263143159951;5531.585131115167;5556.055470570002;5558.777648894039;5566.888662226753;5342.572594192465;5404.189371594262;5435.646682965605;5482.506574408302;5538.196961440589;4967.677100988442;4986.87532811679;5007.974960125194;5081.441041485452;5099.260607211952;5048.091343558158;5055.545000949914;5078.4921507849285;5131.461196574362;5143.691378517301;4769.284607308897;4850.830220942268;4883.462819089933;4991.425986011583;5000.524950129732;4960.851174464736;4966.230234313687;4969.875753106165;4992.425871024842;5051.989602079562;4740.715557066553;4964.429090654585;4972;4979.7012179268995;5050.520200580939;5199.688018718889;5285.947140528622;5307.946920530784;5333.866653333659;5382.9730851345885;5951.553633477506;5960.837636660853;6013.579049466495;6014.939850601481;6031.4270144336215;5760.53915686744;5888.322842873082;6030.396960303979;6043.335233124353;6043.456088951972;5558.638688485235;5627.493525582676;5632.183333416631;5640.5487560995025;5681.431856814327;6165.506759459233;6165.691715414211;6166.229221347332;6178.104174894615;6182.196314479089;5571.1086226203615;5724.79963201286;5917.408259174048;5944.346121926585;5954.345022047572;5682.090865461589;5736.196932429463;5751.194832723422;5752.597318187687;5758.280214973129;5888.352281249059;6015.428534289235;6023.27720673522;6024.57827952048;6070.575059745864;5927.1405646181065;5985.970070149709;5996.16053752475;5996.580239383201;6006.12911127884;4398.956010439854;4493.887652808706;4559.316102584573;4572.108438854458;4596.678232523691;4006.959930400717;4018.557958624549;4030.435738996543;4059.878203653895;4060.675145988314;5626.465485778845;5629.240052592848;5667.1782591524825;5679.204911312419;5680.77276908919;5662.546996240291;5764.423557644286;5783.652980821164;6018.277806663228;6024.849378765566;5604.243427137366;5660.971695141498;5677.772889084473;5702.971485142631;5714.085746280658;5201.219817027476;5214.556762675139;5251.36983561975;5256.973715131477;5293.761780719877;5846.386129456431;5986.4013598639785;6051;6130.724117414727;6135.783919773617;5942.940570594239;5985.281766188085;5993.130996005642;6033.456988871023;6058.182145410313;6074.848128796815;6120.234970628671;6134.2332208473945;6142.508599312134;6145.201123853871;5606.6636001840025;5726.599138060463;5820.30156381237;5915.231019967377;5962.493188079062;6002.039673652369;6007.549433792396;6035.215421995113;6043.3050199227655;6063.757449701962;5549.805756798492;5891.116332550152;5896.027155519291;5911.674857882857;5926.111083337534;5662.263905692398;5676.120201368794;5709.51469125129;5710.314762228559;5714.828555143353;5560.471755183251;5604.159376093618;5617.943820561905;5634.690092044977;5654;5823.417658234142;5847.590668653153;5867.325257595431;5882.588218824641;5895.557833162444;5378.704171270461;5611.4949654529655;5736.139579063174;5744.080947048452;5745.971270143623 20:18:21 INFO - PROCESS | 6918 | |1;ext.html;560.4871542538577;607.4532920371666;607.6627471753178;611.9418655227752;612.445736608369;39018;39377.212455750865;39579.604203957955;39587.802060989656;39710.60289397105;41826.58173418265;42035.36946945798;42210.15579688404;42342.57657423425;42343;8651.65393384264;8727.170918762738;8761.12388761122;8769.210771030606;8802.427842190236;8540.829183416328;8684.43551169172;8737.126287371275;8743;8744.519051452167;8655;8656.134386561356;8704.956475217616;8713.346499012569;8719.60761765719;8662.047174810798;8682.30541556674;8714.69498567547;8724.302055835518;8762.12378762125;8561.400701950866;8647.783805404915;8675.826483470359;8678.088800675965;8710.564471776386;39782.40326395106;39945;40070.59929400727;40093.79953100245;40225.396619050734;3270.9509357359657;3347.6317605063423;3446.5864096308605;3462.41139006367;3604.9098772530633;28965;29231.41537169266;29565.55651665227;29647.5552866705;29814.254643633867;3910.9413358799643;3937.8031098444962;3961.8217180226957;4010.7593544387432;4016.6184212499766;242098;242345;244772;245650;246194;55117.72441137768;55617.443825561226;57008.714956424956;59343.40656593379;59909;53407.46592534025;53416.732916335946;53459.73270133702;53518;53549.73225133927;13503.86496135026;13697.109687870257;13713.108647937852;13720.588382348546;13765.793513097311;10317;10325.690229293134;10349.327293725884;10365.481725913825;10398.68803935883;19261.711074333896;19265.614687706166;19291.228350866088;19342.613147736967;19370.322038728576;7381.557106573623;7593.164751877289;7619.771406857803;7629.05230993526;7656.124249558894;930.2093220762298;931.7344556801279;963.5808423335872;1026.6817286641017;1064.7870425914848;28548.286292842844;29076.418471630448;29427.705722942927;29733.256668583457;29759;986.2997271937005;1009.5911155981839;1022.2588623248234;1050.6427814543092;1096.1833434091652;13819.309034548232;14363.856361436252;14480.131192128507;15305.846941530664;15574.922125389527;304267;307151;308501;309030;309608;51419.228711568605;51505.48494515082;51541.484585154416;51546.22680659793;51729;1301.0957384617789;1301.557470460048;1324.317976242236;1331.9334033298296;1351.797230415426;28203.71796282011;28727.71272287334;28908.265504069823;29309.560356595095;29521.85239073791;45586.772066139456;45613.31580026236;45628;45818.541814581426;45953.540464594924;292088.0142790712;292513;293483;293796;294322;27592.862035689694;27986.72013279841;29958.550621740254;31170.532442012933;31597;37399;37418.62581374151;37948.24103517859;38177.04557385977;38238.42642360422;32257.193570160933;35314.64685353216;35967.64032359748;36252.63747362493;36264.27471450609;33016.50475242922;33536.66463335433;33547.83226083854;34925.65074349224;35110.29779404448;33757.66242337545;34597.48103778395;34605.13487162841;34805.65194348024;34839.825800870836;29840.619535348487;30886.845565772925;31960;32098.67901320957;32272.677273227906;24524.14165504199;24628.261152165465;24724.752752472963;24945.75054249507;25056.24831255065 20:18:21 INFO - PROCESS | 6918 | |2;jquery.html;365.0162811223753;365.65993625927877;365.69464497144867;366.86976123476165;372.10137517894293;16273.267702953366;17035.829641703578;17544.82455175448;17838.28646854126;18059.458216253533;15563.68872622547;15764.211789410541;15855.60360990973;15976.121313327762;16166.83833161668;4908.042931628325;4999.700017998914;5028.547430731233;5046.44489106198;5051.621128415365;4517.412736344287;4971.353724015891;5009.949900501003;5014.222795466709;5019.222020586797;5093.694378337312;5268.1834315680935;5269.288646032794;5405.945940540603;5431.429699881515;5153.948460515385;5197.272381866542;5208.2968799212185;5219.556337711299;5220.243064755608;5258.789648414097;5262.421133675292;5265.947340526623;5271.472852714736;5277.419483856773;14735.70528589433;18725.719114213298;18797.624047519108;19210.615787684306;19265.518362040923;2034.8473864460225;2110.767815540289;2131.1049359269145;2173.804357607823;2245.259064508708;9666.854997175047;9746.269029822792;10000.199984001263;10107.140893024029;10369.688909332732;1821.4717731857745;1863.7483939668107;1875.7936626971023;1893.129160586132;1922.846172306212;58275.15809391019;61903.690481547754;62196.68901655508;62648.373516264706;63342.366576334105;10159.238057145743;10303.948480257552;10337.22470814692;10420;10461.84307235392;13474.797878031837;13522;13524;13533.661658458617;13537.59387218385;7214.531055481377;7268;7295.963520182471;7296.233895441009;7346.155192152971;6773.322667733286;6807.944768560881;6859.382655560924;6871.828204294932;6898.724051037902;4383.802728877208;4411.117776444724;4442.111577684476;4476.6418686505;4490.438695163105;1713.2804222226694;1871.737956686065;1888.2635772048911;1900.3063881683363;1907.685231936715;800.0519384529235;917.7659696777279;937.3110763588757;982.6806287956442;1010.4897027001317;15575.688486230212;15577;15976.680466390839;16631.501054968372;16936.915315423343;934.9579268932914;935.1677007463363;956.2350119904188;974.4786539201493;997.0328781082338;5862.970685146547;6041.667708275999;6203.100550420164;9278.11857873501;9796.804063918682;377918;382569;385504;554865;557580;71170;75058;81498.59250703827;81778;83313.58343208245;476.63061127625673;482.9106615276185;488.99511004890206;489.55450540009133;490.93863267091615;10169.847452288073;10344.586216551254;10547.419891905713;10578.418186999788;10678.519466624177;35162.296754064264;36315.45526817047;36334.45498317474;36680.449793253654;36756.89729308125;47448.05103897972;47952.04095918132;48849;49294.50705493043;49797;9559.378640388632;9578.425294482353;9672.371295865747;9679.177269932135;9767.658131965347;17057.402990895258;17063.317467301666;17800.287988480835;17949.461516154537;17963.910180449013;12139.332336721565;12511.624651260478;13761.587152385444;14805.111693298006;14971.77542336844;12872.420741066488;13019.739605208033;14825.184614846286;15386.153761543223;15510.689786204439;14773.92613036928;14823.851761482247;15082.924585377003;15241.542753717406;15283.541493755205;9729.173020293354;9747.512624368896;9953.701388958343;9955.950220248853;9966.252531060054;13718.65703357424;13728.313584320544;14290.42838286457;14344.56966291013;14876.107433554022 20:18:21 INFO - PROCESS | 6918 | |3;mootools.html;1452.7385070687276;1524.5883611424915;1599.984000159998;1655.84269494398;1790.185465613146;7063.293670632934;7400.259974002597;7490.850182996337;7526.924730752691;7650.8852367214395;7372.852542949137;7378;7411.555306681603;7421.332080112788;7428.480006399541;2288.6681431192424;2339.7192336919593;2340.871252081135;2340.9063637454483;2343.414146463384;2285.7714228577174;2303.1593468384085;2304.6543018547186;2305.262316058862;2351.412146963259;2171.869687818736;2229.5095079082575;2231.419830843976;2288.336382449088;2291.862488250702;2228.3983324502456;2261.5929132756096;2305.5734689082487;2310.1798861404295;2315.2475445480204;2240.7423146338056;2268.0814270220585;2268.1834539565743;2269.8184145268337;2273.3748219239674;7470.103587569472;7523.473356865022;7539.585322807244;7545.69817207311;7553.131389890178;4553.157665831832;4579.290210017452;4599.218132917378;4605.723656580616;4640.907181856378;3040.847957602111;3087.3825234952874;3113.7664675149226;3121.344517651296;3142.874285028596;986.9225280783918;994.8855881573639;1004.2417974429333;1016.5778861950456;1069.8234791259433;10075.899241007643;10141.898581014242;10159.7460063499;10222.744431389201;10223.846642300372;4014.116894283253;4032.495938007749;4060.5330387005283;4089.509258888893;4126.587341265849;8302.667893284322;8319.376046796393;8323.625436855356;8324.334053275723;8340.916590834015;4460.598546130864;4481.641468682497;4491.416115904912;4494.12364588902;4521.525239849834;4068.6338229559483;4091.4272001919753;4098.364753463218;4106.096658735073;4106.342985122366;3428.3314753623304;3443.776154549946;3443.913902152466;3467.2025434150287;3480.2517458746493;1064.1912146768511;1069.4813015687384;1074.908632766208;1077.2082519348273;1080.7622323088908;904.8461761500561;916.7112359606703;1119.9160062995309;1121.2711737370773;1348.3258370814592;6956.130483689539;6980.965095174492;6987.545809522467;7014.438844892396;7059;632.2413104274889;635.8855406026867;643.6009674002148;644.9419552240321;781.8553567589901;5474.124140137559;5481.506664400223;5528.917066244009;5535.418781028015;5546.168074788814;8692.304615630734;8837.585986242299;8978.191962723386;8994.775130621787;9170.67902623405;9008.099190081071;9013.369064165576;9021.639134434548;9091.590878410487;9112.179903808557;6865.862682746317;6892.931070689329;6910.723571057202;7099.290070992859;7218.061651985313;6914.688839002358;6933.237343892067;6945.513814032969;6956.373926346653;6965.33829286217;7893.329067029367;8058.919410805817;8158.347332213528;8176.059753128467;8258.339332853237;8182.83634327322;8328.708495202638;8348.415610907177;8367.12145224767;8479.533625650649;6407.391297826699;6446.258680251831;6467.223933128054;6508.251551071688;6514.055461958084;7360.96319518399;7422.331990120915;7435.665395057127;7436.996005539183;7448.627568621656;6724.394804467622;6849.760258390932;7046.718131274692;7114.075170228044;7148.142222933281;6490.902636460362;6547.574407663486;6589.967050164719;6784.050232967487;6918.688659010256;6416.550841441054;6537.70580323877;6545.738170473318;6551;6563.3764792344655;6066.241719785027;6073.696315184135;6074.878502429839;6112.083187521729;6121.265448146251;6063.787767428119;6068.059450784959;6084.726187321493;6104;6156.938430615636 20:18:21 INFO - PROCESS | 6918 | |4;prototype.html;349.1132523390588;352.52057202205;353.1330583417709;355.1582748885141;357.5673435143476;6174.289956654986;6255.843603909904;6283.52873534485;6329.77845775398;6356.07836863655;6110.755569777203;6279.937200627993;6280.4347608715325;6282.842928926779;6353.047042943561;4813;4844.394450693663;4849.10291596055;4850;4861.902761944759;4843.854684359458;4847.12751704693;4859.659823812334;4874.2688596710595;4884.438289596688;4733.171694953387;4805.783739731703;4806.327114204014;4814.66297359185;4819.7590120494015;4792.394547826482;4794.616430685537;4810.8797280068275;4816.975915120437;4826.155422800995;4199.874003779892;4207.1165055338415;4214.789260536961;4228;4237.343211802145;5962.34414214436;6022.247219097613;6026.337102918676;6027.126066720345;6028.125921741323;5440.972795136038;5572.749226284827;5592.105263157875;5597.132444471114;5609.046462101453;6632.734690612369;6642.136522252076;6645.867082658319;6664.300248473889;6676.866462670768;4690.59282215334;4692.1084993851055;4694.788734506921;4695.60087392572;4707.176244157293;6691.799246022627;6916.861662766716;6957.443404527626;6972.988916607063;6978.302169782981;4661.650376221797;4683.625309975194;4701.905961880743;4706.764661766898;4708.081924024782;4738.170820106537;4753.239481682914;4755.812326329858;4756.9286460703115;4765.356676848651;5531.308586426697;5535.308086489189;5539.584531160099;5554.666719996813;5556;6567.540272180901;6725.092112564839;6729.05793188954;6731.798046058626;6732.293109223461;1648.0935485483176;1659.0543390267433;1666.0503512997475;1675.5978565144278;1680.7226807576612;1128.2948157401624;1134.5802053240354;1141.8972292493715;1143.17691262291;1152.141654467427;6371.936280637227;6409.294977552466;6446;6464.385883341075;6464.676766161673;6817.113775209191;6835.521513494107;6891.069705589782;6903.447724182053;6905.75829845953;6364.077208804697;6381.489480841522;6403.3276505966205;6433.613983160932;6439.484841212692;3770.3967365221984;3782.3759079751535;3824.5028146341356;3833.769973801581;3846.7307288489537;7274.672639731225;7276.963615181996;7287.380572651384;7287.526310789782;7311.634418279064;7081.645917704094;7223.891641625275;7228.602426866572;7230.855382892312;7273.418126549864;7190.280971902873;7208.459365547605;7239.420846332281;7253.984442178099;7270.781876543606;6992.650367481708;7019.052427922369;7029.121359830021;7029.715342513601;7041.119860017498;6714;6867.862642747217;6872.347127022925;6897.689603967934;6966.059581956371;7169.426445884213;7176.390006849476;7180.60506672138;7188.5327453715345;7203.775358189016;4610.861674149781;4616.9307460387445;4631.374764406897;4635.884102897319;4645.419322584677;6808.557443766139;6844.794656160323;6921.446284297143;7000.19497757744;7030.156381234285;6801;6824.590524568542;6825.761098361533;6846.520743548103;6851.828704282433;6768.898466522907;6793.490488213502;6799.966000169968;6819.283975182534;6824.7952561423235;6540.363342431085;6647.734090636513;6659.600423974383;6697.598144111369;6704.195496540447;6778.93221067783;6840.521163518506;6862.897056544056;6870.484713646397;6875.312468753084;6682.799516014527;6683.598984060972;6689.8327541809895;6695.564788288746;6707 20:18:21 INFO - PROCESS | 6918 | |5;yui.html;758.457702742539;802.7190483330833;804.1315379390255;829.8506268871605;860.1011942520066;13764.655883602902;14087.50693725721;14090.225037622926;14174.433022679106;14198.645033874145;13075.673108172277;13102.213867167977;13227.537036203736;13250.933745331284;13289.401976911038;837.6733074101105;854.9059603443616;856.3021137772695;856.6530555125184;858.7166235142388;851.2849206666399;859.3211363023236;860.0410542245382;860.5912191708951;860.6858496648741;893.9106089391041;898.7753061734567;898.8067565473422;900.158351940934;901.143913282381;889.328556939513;894.6019021535419;895.3911340288602;895.7178488776015;896.4845214001975;650.3593959949446;654.8133781872191;655.1613934164277;655.8458762190882;656.0814859197114;13979.860201397958;13998.30008499571;14018.22899740524;14054.578362649137;14112.71774564503;11941.402929853473;12364.319962402064;12461.837496439755;12609.684757881034;12694.80957785634;10433.895661043369;10461.843072353844;10639.840402393971;10701.732456688645;10755.408452535108;3582.17609949713;3619.4208926571887;3622.7464077514583;3637;3658.2866341063504;42266.1546769066;44040.77979610081;44515.33227001598;44782.552174478165;44939.55060449387;9259.212966897754;9527.237820974306;10137.746556336151;10147.64483243083;10169.898301016896;17552.122393880254;17554.38559650406;17574.82425175732;17626.823731762775;17844.286228550973;7363.263673632594;7494.700211991569;7528.811779705442;7554.2823431773895;7558.773236802905;4003.619656132663;4044.5753195914003;4061.0647647578116;4069.2268468990796;4092.0792821615496;3086.66046734859;3105.897406420733;3116.9844150779554;3119.5944527211773;3132.37352529495;568.6616463204386;575.5424437572141;579.1139556478595;579.8637320229743;608.3247595169358;585.5249096611624;671.3387313496203;692.3768608252612;698.9446627616758;714.9642517874086;7830.882536761953;8596.011458682331;8627.827443451095;8670.653173873101;8888.911110888937;590.9261342332209;633.4868756307405;692.882210024287;694.6422592364936;718.0270733156602;3601.603823579404;3889.202713443737;4037.989372139481;4109.363048727452;4224.239636865394;55289.72355138279;55587;55689.44310556923;55880.16179757307;56096.43903560994;49029.26456103161;49715;50119.74940125349;51373.22940155901;51879;40740;45444.772776135906;45631.08737825225;45728.54271457243;45915.54084459179;8330;8408.87386689188;8486.74539763808;8777.297816174818;8957.955210223907;35252.29495410026;35708.821455892554;35855.46216806698;36439.81780091082;36468.635313646526;39901.201975960896;39995.60004400035;43155.136897261254;45260.09479810319;45533.54466455293;10649.840252396065;10759.193060520336;10776;10777;10811.837822432513;11938.552596717826;12215.816762748389;12220.75558488843;12313.753724925631;12446.315452650191;10341.896581034094;10368.410097826481;10383.792324153626;10454.790904182026;10597.046265836112;10879.619213327496;11003.724906877393;11232.7753444929;11274.887251127384;11500.712482188012;9865.309428340235;9893.159081478156;10073.19414446857;10100.949495252476;10362.171026317727;9971.152452041657;10080.495975201356;10120.291579589359;10226.6420675276;10818.242723009314;8766.254868336007;8936.687215947411;9337.253019758538;9689.273304502332;9780.902190978284 20:18:21 INFO - PROCESS | 6918 | __end_tp_report 20:18:21 INFO - PROCESS | 6918 | __start_cc_report 20:18:21 INFO - PROCESS | 6918 | _x_x_mozilla_cycle_collect,318 20:18:21 INFO - PROCESS | 6918 | __end_cc_report 20:18:21 INFO - PROCESS | 6918 | __startTimestamp1450757901875__endTimestamp 20:18:21 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | ------- Summary: start ------- 20:18:21 INFO - PROCESS | 6918 | Number of tests: 6 20:18:21 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | [#0] dojo.html Cycles:165 Average:5496.44 Median:5677.77 stddev:630.00 (11.1%) stddev-sans-first:605.62 20:18:21 INFO - PROCESS | 6918 | Values: 3199.8 3268.1 3288.3 3312.0 3318.5 5263.3 5531.6 5556.1 5558.8 5566.9 5342.6 5404.2 5435.6 5482.5 5538.2 4967.7 4986.9 5008.0 5081.4 5099.3 5048.1 5055.5 5078.5 5131.5 5143.7 4769.3 4850.8 4883.5 4991.4 5000.5 4960.9 4966.2 4969.9 4992.4 5052.0 4740.7 4964.4 4972.0 4979.7 5050.5 5199.7 5285.9 5307.9 5333.9 5383.0 5951.6 5960.8 6013.6 6014.9 6031.4 5760.5 5888.3 6030.4 6043.3 6043.5 5558.6 5627.5 5632.2 5640.5 5681.4 6165.5 6165.7 6166.2 6178.1 6182.2 5571.1 5724.8 5917.4 5944.3 5954.3 5682.1 5736.2 5751.2 5752.6 5758.3 5888.4 6015.4 6023.3 6024.6 6070.6 5927.1 5986.0 5996.2 5996.6 6006.1 4399.0 4493.9 4559.3 4572.1 4596.7 4007.0 4018.6 4030.4 4059.9 4060.7 5626.5 5629.2 5667.2 5679.2 5680.8 5662.5 5764.4 5783.7 6018.3 6024.8 5604.2 5661.0 5677.8 5703.0 5714.1 5201.2 5214.6 5251.4 5257.0 5293.8 5846.4 5986.4 6051.0 6130.7 6135.8 5942.9 5985.3 5993.1 6033.5 6058.2 6074.8 6120.2 6134.2 6142.5 6145.2 5606.7 5726.6 5820.3 5915.2 5962.5 6002.0 6007.5 6035.2 6043.3 6063.8 5549.8 5891.1 5896.0 5911.7 5926.1 5662.3 5676.1 5709.5 5710.3 5714.8 5560.5 5604.2 5617.9 5634.7 5654.0 5823.4 5847.6 5867.3 5882.6 5895.6 5378.7 5611.5 5736.1 5744.1 5746.0 20:18:21 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | [#1] ext.html Cycles:180 Average:44736.24 Median:35212.47 stddev:73905.09 (209.9%) stddev-sans-first:74037.98 20:18:21 INFO - PROCESS | 6918 | Values: 560.5 607.5 607.7 611.9 612.4 39018.0 39377.2 39579.6 39587.8 39710.6 41826.6 42035.4 42210.2 42342.6 42343.0 8651.7 8727.2 8761.1 8769.2 8802.4 8540.8 8684.4 8737.1 8743.0 8744.5 8655.0 8656.1 8705.0 8713.3 8719.6 8662.0 8682.3 8714.7 8724.3 8762.1 8561.4 8647.8 8675.8 8678.1 8710.6 39782.4 39945.0 40070.6 40093.8 40225.4 3271.0 3347.6 3446.6 3462.4 3604.9 28965.0 29231.4 29565.6 29647.6 29814.3 3910.9 3937.8 3961.8 4010.8 4016.6 242098.0 242345.0 244772.0 245650.0 246194.0 55117.7 55617.4 57008.7 59343.4 59909.0 53407.5 53416.7 53459.7 53518.0 53549.7 13503.9 13697.1 13713.1 13720.6 13765.8 10317.0 10325.7 10349.3 10365.5 10398.7 19261.7 19265.6 19291.2 19342.6 19370.3 7381.6 7593.2 7619.8 7629.1 7656.1 930.2 931.7 963.6 1026.7 1064.8 28548.3 29076.4 29427.7 29733.3 29759.0 986.3 1009.6 1022.3 1050.6 1096.2 13819.3 14363.9 14480.1 15305.8 15574.9 304267.0 307151.0 308501.0 309030.0 309608.0 51419.2 51505.5 51541.5 51546.2 51729.0 1301.1 1301.6 1324.3 1331.9 1351.8 28203.7 28727.7 28908.3 29309.6 29521.9 45586.8 45613.3 45628.0 45818.5 45953.5 292088.0 292513.0 293483.0 293796.0 294322.0 27592.9 27986.7 29958.6 31170.5 31597.0 37399.0 37418.6 37948.2 38177.0 38238.4 32257.2 35314.6 35967.6 36252.6 36264.3 33016.5 33536.7 33547.8 34925.7 35110.3 33757.7 34597.5 34605.1 34805.7 34839.8 29840.6 30886.8 31960.0 32098.7 32272.7 24524.1 24628.3 24724.8 24945.8 25056.2 20:18:21 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | [#2] jquery.html Cycles:180 Average:26200.39 Median:384036.50 stddev:75408.46 (19.6%) stddev-sans-first:75595.05 20:18:21 INFO - PROCESS | 6918 | Values: 365.0 365.7 365.7 366.9 372.1 16273.3 17035.8 17544.8 17838.3 18059.5 15563.7 15764.2 15855.6 15976.1 16166.8 4908.0 4999.7 5028.5 5046.4 5051.6 4517.4 4971.4 5009.9 5014.2 5019.2 5093.7 5268.2 5269.3 5405.9 5431.4 5153.9 5197.3 5208.3 5219.6 5220.2 5258.8 5262.4 5265.9 5271.5 5277.4 14735.7 18725.7 18797.6 19210.6 19265.5 2034.8 2110.8 2131.1 2173.8 2245.3 9666.9 9746.3 10000.2 10107.1 10369.7 1821.5 1863.7 1875.8 1893.1 1922.8 58275.2 61903.7 62196.7 62648.4 63342.4 10159.2 10303.9 10337.2 10420.0 10461.8 13474.8 13522.0 13524.0 13533.7 13537.6 7214.5 7268.0 7296.0 7296.2 7346.2 6773.3 6807.9 6859.4 6871.8 6898.7 4383.8 4411.1 4442.1 4476.6 4490.4 1713.3 1871.7 1888.3 1900.3 1907.7 800.1 917.8 937.3 982.7 1010.5 15575.7 15577.0 15976.7 16631.5 16936.9 935.0 935.2 956.2 974.5 997.0 5863.0 6041.7 6203.1 9278.1 9796.8 377918.0 382569.0 385504.0 554865.0 557580.0 71170.0 75058.0 81498.6 81778.0 83313.6 476.6 482.9 489.0 489.6 490.9 10169.8 10344.6 10547.4 10578.4 10678.5 35162.3 36315.5 36334.5 36680.4 36756.9 47448.1 47952.0 48849.0 49294.5 49797.0 9559.4 9578.4 9672.4 9679.2 9767.7 17057.4 17063.3 17800.3 17949.5 17963.9 12139.3 12511.6 13761.6 14805.1 14971.8 12872.4 13019.7 14825.2 15386.2 15510.7 14773.9 14823.9 15082.9 15241.5 15283.5 9729.2 9747.5 9953.7 9956.0 9966.3 13718.7 13728.3 14290.4 14344.6 14876.1 20:18:21 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | [#3] mootools.html Cycles:180 Average:5240.07 Median:3394.59 stddev:2694.64 (79.4%) stddev-sans-first:2687.16 20:18:21 INFO - PROCESS | 6918 | Values: 1452.7 1524.6 1600.0 1655.8 1790.2 7063.3 7400.3 7490.9 7526.9 7650.9 7372.9 7378.0 7411.6 7421.3 7428.5 2288.7 2339.7 2340.9 2340.9 2343.4 2285.8 2303.2 2304.7 2305.3 2351.4 2171.9 2229.5 2231.4 2288.3 2291.9 2228.4 2261.6 2305.6 2310.2 2315.2 2240.7 2268.1 2268.2 2269.8 2273.4 7470.1 7523.5 7539.6 7545.7 7553.1 4553.2 4579.3 4599.2 4605.7 4640.9 3040.8 3087.4 3113.8 3121.3 3142.9 986.9 994.9 1004.2 1016.6 1069.8 10075.9 10141.9 10159.7 10222.7 10223.8 4014.1 4032.5 4060.5 4089.5 4126.6 8302.7 8319.4 8323.6 8324.3 8340.9 4460.6 4481.6 4491.4 4494.1 4521.5 4068.6 4091.4 4098.4 4106.1 4106.3 3428.3 3443.8 3443.9 3467.2 3480.3 1064.2 1069.5 1074.9 1077.2 1080.8 904.8 916.7 1119.9 1121.3 1348.3 6956.1 6981.0 6987.5 7014.4 7059.0 632.2 635.9 643.6 644.9 781.9 5474.1 5481.5 5528.9 5535.4 5546.2 8692.3 8837.6 8978.2 8994.8 9170.7 9008.1 9013.4 9021.6 9091.6 9112.2 6865.9 6892.9 6910.7 7099.3 7218.1 6914.7 6933.2 6945.5 6956.4 6965.3 7893.3 8058.9 8158.3 8176.1 8258.3 8182.8 8328.7 8348.4 8367.1 8479.5 6407.4 6446.3 6467.2 6508.3 6514.1 7361.0 7422.3 7435.7 7437.0 7448.6 6724.4 6849.8 7046.7 7114.1 7148.1 6490.9 6547.6 6590.0 6784.1 6918.7 6416.6 6537.7 6545.7 6551.0 6563.4 6066.2 6073.7 6074.9 6112.1 6121.3 6063.8 6068.1 6084.7 6104.0 6156.9 20:18:21 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | [#4] prototype.html Cycles:180 Average:5622.92 Median:6368.01 stddev:1708.93 (26.8%) stddev-sans-first:1667.25 20:18:21 INFO - PROCESS | 6918 | Values: 349.1 352.5 353.1 355.2 357.6 6174.3 6255.8 6283.5 6329.8 6356.1 6110.8 6279.9 6280.4 6282.8 6353.0 4813.0 4844.4 4849.1 4850.0 4861.9 4843.9 4847.1 4859.7 4874.3 4884.4 4733.2 4805.8 4806.3 4814.7 4819.8 4792.4 4794.6 4810.9 4817.0 4826.2 4199.9 4207.1 4214.8 4228.0 4237.3 5962.3 6022.2 6026.3 6027.1 6028.1 5441.0 5572.7 5592.1 5597.1 5609.0 6632.7 6642.1 6645.9 6664.3 6676.9 4690.6 4692.1 4694.8 4695.6 4707.2 6691.8 6916.9 6957.4 6973.0 6978.3 4661.7 4683.6 4701.9 4706.8 4708.1 4738.2 4753.2 4755.8 4756.9 4765.4 5531.3 5535.3 5539.6 5554.7 5556.0 6567.5 6725.1 6729.1 6731.8 6732.3 1648.1 1659.1 1666.1 1675.6 1680.7 1128.3 1134.6 1141.9 1143.2 1152.1 6371.9 6409.3 6446.0 6464.4 6464.7 6817.1 6835.5 6891.1 6903.4 6905.8 6364.1 6381.5 6403.3 6433.6 6439.5 3770.4 3782.4 3824.5 3833.8 3846.7 7274.7 7277.0 7287.4 7287.5 7311.6 7081.6 7223.9 7228.6 7230.9 7273.4 7190.3 7208.5 7239.4 7254.0 7270.8 6992.7 7019.1 7029.1 7029.7 7041.1 6714.0 6867.9 6872.3 6897.7 6966.1 7169.4 7176.4 7180.6 7188.5 7203.8 4610.9 4616.9 4631.4 4635.9 4645.4 6808.6 6844.8 6921.4 7000.2 7030.2 6801.0 6824.6 6825.8 6846.5 6851.8 6768.9 6793.5 6800.0 6819.3 6824.8 6540.4 6647.7 6659.6 6697.6 6704.2 6778.9 6840.5 6862.9 6870.5 6875.3 6682.8 6683.6 6689.8 6695.6 6707.0 20:18:21 INFO - PROCESS | 6918 | 20:18:21 INFO - PROCESS | 6918 | [#5] yui.html Cycles:180 Average:13496.82 Median:44278.06 stddev:15375.16 (34.7%) stddev-sans-first:15388.53 20:18:21 INFO - PROCESS | 6918 | Values: 758.5 802.7 804.1 829.9 860.1 13764.7 14087.5 14090.2 14174.4 14198.6 13075.7 13102.2 13227.5 13250.9 13289.4 837.7 854.9 856.3 856.7 858.7 851.3 859.3 860.0 860.6 860.7 893.9 898.8 898.8 900.2 901.1 889.3 894.6 895.4 895.7 896.5 650.4 654.8 655.2 655.8 656.1 13979.9 13998.3 14018.2 14054.6 14112.7 11941.4 12364.3 12461.8 12609.7 12694.8 10433.9 10461.8 10639.8 10701.7 10755.4 3582.2 3619.4 3622.7 3637.0 3658.3 42266.2 44040.8 44515.3 44782.6 44939.6 9259.2 9527.2 10137.7 10147.6 10169.9 17552.1 17554.4 17574.8 17626.8 17844.3 7363.3 7494.7 7528.8 7554.3 7558.8 4003.6 4044.6 4061.1 4069.2 4092.1 3086.7 3105.9 3117.0 3119.6 3132.4 568.7 575.5 579.1 579.9 608.3 585.5 671.3 692.4 698.9 715.0 7830.9 8596.0 8627.8 8670.7 8888.9 590.9 633.5 692.9 694.6 718.0 3601.6 3889.2 4038.0 4109.4 4224.2 55289.7 55587.0 55689.4 55880.2 56096.4 49029.3 49715.0 50119.7 51373.2 51879.0 40740.0 45444.8 45631.1 45728.5 45915.5 8330.0 8408.9 8486.7 8777.3 8958.0 35252.3 35708.8 35855.5 36439.8 36468.6 39901.2 39995.6 43155.1 45260.1 45533.5 10649.8 10759.2 10776.0 10777.0 10811.8 11938.6 12215.8 12220.8 12313.8 12446.3 10341.9 10368.4 10383.8 10454.8 10597.0 10879.6 11003.7 11232.8 11274.9 11500.7 9865.3 9893.2 10073.2 10100.9 10362.2 9971.2 10080.5 10120.3 10226.6 10818.2 8766.3 8936.7 9337.3 9689.3 9780.9 20:18:21 INFO - PROCESS | 6918 | -------- Summary: end -------- 20:18:21 INFO - PROCESS | 6918 | 20:18:22 INFO - TEST-INFO | 6918: exit 0 20:18:22 INFO - TEST-OK | dromaeo_css | took 1111446ms 20:18:22 INFO - TEST-START | kraken 20:18:22 INFO - operating with platform_type : linux_ 20:18:22 INFO - Initialising browser for kraken test... 20:18:22 INFO - TEST-INFO | started process 7162 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvr0fIv/profile http://localhost:36972/getInfo.html) 20:18:26 INFO - PROCESS | 7162 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 20:18:27 INFO - PROCESS | 7162 | __metrics Screen width/height:1600/1200 20:18:27 INFO - PROCESS | 7162 | colorDepth:24 20:18:27 INFO - PROCESS | 7162 | Browser inner width/height: 1024/697 20:18:27 INFO - PROCESS | 7162 | __metrics 20:18:27 INFO - PROCESS | 7162 | 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:28 INFO - TEST-INFO | 7162: exit 0 20:18:28 INFO - Browser initialized. 20:18:28 INFO - Running cycle 1/1 for kraken test... 20:18:28 INFO - TEST-INFO | started process 7286 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvr0fIv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:40 INFO - PROCESS | 7286 | RSS: Main: 151035904 20:18:40 INFO - PROCESS | 7286 | 20:18:42 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36972/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:43 INFO - PROCESS | 7286 | RSS: Main: 152358912 20:18:43 INFO - PROCESS | 7286 | 20:18:46 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36972/tests/kraken/driver.html?testName=audio-dft) 20:18:46 INFO - PROCESS | 7286 | RSS: Main: 151973888 20:18:46 INFO - PROCESS | 7286 | 20:18:49 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36972/tests/kraken/driver.html?testName=audio-fft) 20:18:50 INFO - PROCESS | 7286 | RSS: Main: 146481152 20:18:50 INFO - PROCESS | 7286 | 20:18:52 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36972/tests/kraken/driver.html?testName=audio-oscillator) 20:18:52 INFO - PROCESS | 7286 | RSS: Main: 146698240 20:18:52 INFO - PROCESS | 7286 | 20:18:54 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:55 INFO - PROCESS | 7286 | RSS: Main: 147087360 20:18:55 INFO - PROCESS | 7286 | 20:18:58 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36972/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:59 INFO - PROCESS | 7286 | RSS: Main: 146935808 20:18:59 INFO - PROCESS | 7286 | 20:19:02 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36972/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:02 INFO - PROCESS | 7286 | RSS: Main: 148262912 20:19:02 INFO - PROCESS | 7286 | 20:19:05 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36972/tests/kraken/driver.html?testName=json-parse-financial) 20:19:06 INFO - PROCESS | 7286 | RSS: Main: 148492288 20:19:06 INFO - PROCESS | 7286 | 20:19:07 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:08 INFO - PROCESS | 7286 | RSS: Main: 149463040 20:19:08 INFO - PROCESS | 7286 | 20:19:10 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36972/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:10 INFO - PROCESS | 7286 | RSS: Main: 149889024 20:19:10 INFO - PROCESS | 7286 | 20:19:13 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:13 INFO - PROCESS | 7286 | RSS: Main: 150204416 20:19:13 INFO - PROCESS | 7286 | 20:19:16 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:16 INFO - PROCESS | 7286 | RSS: Main: 148504576 20:19:16 INFO - PROCESS | 7286 | 20:19:19 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:19 INFO - PROCESS | 7286 | RSS: Main: 149774336 20:19:19 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | Cycle 1(1): loaded http://localhost:36972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36972/tests/kraken/driver.html?testName=ai-astar) 20:19:21 INFO - PROCESS | 7286 | RSS: Main: 150478848 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | __start_tp_report 20:19:21 INFO - PROCESS | 7286 | _x_x_mozilla_page_load 20:19:21 INFO - PROCESS | 7286 | _x_x_mozilla_page_load_details 20:19:21 INFO - PROCESS | 7286 | |i|pagename|runs| 20:19:21 INFO - PROCESS | 7286 | |0;ai-astar;111;107;113;111;110;123;112;111;111;110 20:19:21 INFO - PROCESS | 7286 | |1;audio-beat-detection;147;123;155;167;124;147;153;130;163;124 20:19:21 INFO - PROCESS | 7286 | |2;audio-dft;162;162;161;160;171;162;160;166;170;162 20:19:21 INFO - PROCESS | 7286 | |3;audio-fft;72;73;73;72;72;73;139;71;73;73 20:19:21 INFO - PROCESS | 7286 | |4;audio-oscillator;94;94;140;93;93;94;142;94;94;140 20:19:21 INFO - PROCESS | 7286 | |5;imaging-gaussian-blur;110;111;110;111;110;110;110;110;110;110 20:19:21 INFO - PROCESS | 7286 | |6;imaging-darkroom;150;147;146;147;146;147;146;147;146;145 20:19:21 INFO - PROCESS | 7286 | |7;imaging-desaturate;95;97;97;100;97;96;95;97;97;96 20:19:21 INFO - PROCESS | 7286 | |8;json-parse-financial;61;71;61;61;64;69;70;61;64;60 20:19:21 INFO - PROCESS | 7286 | |9;json-stringify-tinderbox;68;73;66;67;68;68;67;67;68;68 20:19:21 INFO - PROCESS | 7286 | |10;stanford-crypto-aes;83;86;101;87;93;85;85;84;86;84 20:19:21 INFO - PROCESS | 7286 | |11;stanford-crypto-ccm;122;126;133;117;118;125;131;125;119;118 20:19:21 INFO - PROCESS | 7286 | |12;stanford-crypto-pbkdf2;147;155;145;155;153;142;169;156;154;144 20:19:21 INFO - PROCESS | 7286 | |13;stanford-crypto-sha256-iterative;76;73;70;67;68;67;70;73;70;67 20:19:21 INFO - PROCESS | 7286 | __end_tp_report 20:19:21 INFO - PROCESS | 7286 | __start_cc_report 20:19:21 INFO - PROCESS | 7286 | _x_x_mozilla_cycle_collect,712 20:19:21 INFO - PROCESS | 7286 | __end_cc_report 20:19:21 INFO - PROCESS | 7286 | __startTimestamp1450757961862__endTimestamp 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | ------- Summary: start ------- 20:19:21 INFO - PROCESS | 7286 | Number of tests: 14 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.20 (3.8%) stddev-sans-first:4.44 20:19:21 INFO - PROCESS | 7286 | Values: 111.0 107.0 113.0 111.0 110.0 123.0 112.0 111.0 111.0 110.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.00 stddev:16.81 (11.2%) stddev-sans-first:17.77 20:19:21 INFO - PROCESS | 7286 | Values: 147.0 123.0 155.0 167.0 124.0 147.0 153.0 130.0 163.0 124.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.00 stddev:4.01 (2.5%) stddev-sans-first:4.21 20:19:21 INFO - PROCESS | 7286 | Values: 162.0 162.0 161.0 160.0 171.0 162.0 160.0 166.0 170.0 162.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#3] audio-fft Cycles:10 Average:79.10 Median:73.00 stddev:21.06 (28.8%) stddev-sans-first:22.18 20:19:21 INFO - PROCESS | 7286 | Values: 72.0 73.0 73.0 72.0 72.0 73.0 139.0 71.0 73.0 73.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:94.00 stddev:22.69 (24.1%) stddev-sans-first:23.51 20:19:21 INFO - PROCESS | 7286 | Values: 94.0 94.0 140.0 93.0 93.0 94.0 142.0 94.0 94.0 140.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:19:21 INFO - PROCESS | 7286 | Values: 110.0 111.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.34 (0.9%) stddev-sans-first:0.71 20:19:21 INFO - PROCESS | 7286 | Values: 150.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 145.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:1.42 (1.5%) stddev-sans-first:1.36 20:19:21 INFO - PROCESS | 7286 | Values: 95.0 97.0 97.0 100.0 97.0 96.0 95.0 97.0 97.0 96.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:4.24 (6.6%) stddev-sans-first:4.33 20:19:21 INFO - PROCESS | 7286 | Values: 61.0 71.0 61.0 61.0 64.0 69.0 70.0 61.0 64.0 60.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:2.00 20:19:21 INFO - PROCESS | 7286 | Values: 68.0 73.0 66.0 67.0 68.0 68.0 67.0 67.0 68.0 68.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:85.50 stddev:5.52 (6.5%) stddev-sans-first:5.62 20:19:21 INFO - PROCESS | 7286 | Values: 83.0 86.0 101.0 87.0 93.0 85.0 85.0 84.0 86.0 84.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:125.00 stddev:5.60 (4.5%) stddev-sans-first:5.92 20:19:21 INFO - PROCESS | 7286 | Values: 122.0 126.0 133.0 117.0 118.0 125.0 131.0 125.0 119.0 118.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:154.50 stddev:7.93 (5.1%) stddev-sans-first:8.20 20:19:21 INFO - PROCESS | 7286 | Values: 147.0 155.0 145.0 155.0 153.0 142.0 169.0 156.0 154.0 144.0 20:19:21 INFO - PROCESS | 7286 | 20:19:21 INFO - PROCESS | 7286 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:3.07 (4.4%) stddev-sans-first:2.40 20:19:21 INFO - PROCESS | 7286 | Values: 76.0 73.0 70.0 67.0 68.0 67.0 70.0 73.0 70.0 67.0 20:19:21 INFO - PROCESS | 7286 | -------- Summary: end -------- 20:19:21 INFO - PROCESS | 7286 | 20:19:22 INFO - TEST-INFO | 7286: exit 0 20:19:22 INFO - TEST-OK | kraken | took 60198ms 20:19:22 INFO - TEST-START | v8_7 20:19:22 INFO - operating with platform_type : linux_ 20:19:22 INFO - Initialising browser for v8_7 test... 20:19:22 INFO - TEST-INFO | started process 7573 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp69moAK/profile http://localhost:36972/getInfo.html) 20:19:26 INFO - PROCESS | 7573 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 20:19:27 INFO - PROCESS | 7573 | __metrics Screen width/height:1600/1200 20:19:27 INFO - PROCESS | 7573 | colorDepth:24 20:19:27 INFO - PROCESS | 7573 | Browser inner width/height: 1024/697 20:19:27 INFO - PROCESS | 7573 | __metrics 20:19:27 INFO - PROCESS | 7573 | 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:19:28 INFO - TEST-INFO | 7573: exit 0 20:19:28 INFO - Browser initialized. 20:19:28 INFO - Running cycle 1/1 for v8_7 test... 20:19:28 INFO - TEST-INFO | started process 7699 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp69moAK/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:40 INFO - PROCESS | 7699 | RSS: Main: 151138304 20:19:40 INFO - PROCESS | 7699 | 20:20:01 INFO - PROCESS | 7699 | Cycle 1(1): loaded http://localhost:36972/tests/v8_7/run.html (next: http://localhost:36972/tests/v8_7/run.html) 20:20:02 INFO - PROCESS | 7699 | RSS: Main: 146628608 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | __start_tp_report 20:20:02 INFO - PROCESS | 7699 | _x_x_mozilla_page_load 20:20:02 INFO - PROCESS | 7699 | _x_x_mozilla_page_load_details 20:20:02 INFO - PROCESS | 7699 | |i|pagename|runs| 20:20:02 INFO - PROCESS | 7699 | |0;Richards;166.05778811026238 20:20:02 INFO - PROCESS | 7699 | |1;DeltaBlue;194.32568985619898 20:20:02 INFO - PROCESS | 7699 | |2;Encrypt;282.9654782116582 20:20:02 INFO - PROCESS | 7699 | |3;Decrypt;5240.837696335078 20:20:02 INFO - PROCESS | 7699 | |4;RayTrace;1062.6992561105208 20:20:02 INFO - PROCESS | 7699 | |5;Earley;754.7169811320755 20:20:02 INFO - PROCESS | 7699 | |6;Boyer;12256.09756097561 20:20:02 INFO - PROCESS | 7699 | |7;RegExp;25948.71794871795 20:20:02 INFO - PROCESS | 7699 | |8;Splay;569.4760820045558 20:20:02 INFO - PROCESS | 7699 | |9;NavierStokes;4873.78640776699 20:20:02 INFO - PROCESS | 7699 | __end_tp_report 20:20:02 INFO - PROCESS | 7699 | __startTimestamp1450758002187__endTimestamp 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | ------- Summary: start ------- 20:20:02 INFO - PROCESS | 7699 | Number of tests: 10 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 166.1 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#1] DeltaBlue Cycles:1 Average:194.33 Median:194.33 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 194.3 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#2] Encrypt Cycles:1 Average:282.97 Median:282.97 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 283.0 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 5240.8 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 1062.7 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#5] Earley Cycles:1 Average:754.72 Median:754.72 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 754.7 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 12256.1 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 25948.7 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#8] Splay Cycles:1 Average:569.48 Median:569.48 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 569.5 20:20:02 INFO - PROCESS | 7699 | 20:20:02 INFO - PROCESS | 7699 | [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 20:20:02 INFO - PROCESS | 7699 | Values: 4873.8 20:20:02 INFO - PROCESS | 7699 | -------- Summary: end -------- 20:20:02 INFO - PROCESS | 7699 | 20:20:03 INFO - TEST-INFO | 7699: exit 0 20:20:03 INFO - TEST-OK | v8_7 | took 40213ms 20:20:03 INFO - SUITE-END | took 1211s 20:20:03 INFO - Completed test suite (00:20:11) 20:20:03 INFO - Working with test: dromaeo_css 20:20:03 INFO - Generating results file: dromaeo_css 20:20:03 INFO - Working with test: kraken 20:20:03 INFO - Generating results file: kraken 20:20:03 INFO - javascript benchmark 20:20:03 INFO - Working with test: v8_7 20:20:03 INFO - Generating results file: v8_7 20:20:03 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:20:08 INFO - process_Request line: dromaeo_css 6958.05 graph.html#tests=[[72,64,43]] 20:20:08 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:08 INFO - process_Request line: kraken 1524.40 graph.html#tests=[[232,64,43]] 20:20:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:08 INFO - process_Request line: v8_7 21207.35 graph.html#tests=[[230,64,43]] 20:20:08 INFO - RETURN: dromaeo_css: 6958.05 20:20:08 INFO - RETURN: kraken: 1524.40 20:20:08 INFO - RETURN: v8_7: 21207.35 20:20:08 INFO - javascript benchmark 20:20:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3199.824009679468, 3268.0522648431956, 3288.2765791525885, 3312.039508542523, 3318.518814771858, 5263.263143159951, 5531.585131115167, 5556.055470570002, 5558.777648894039, 5566.888662226753, 5342.572594192465, 5404.189371594262, 5435.646682965605, 5482.506574408302, 5538.196961440589, 4967.677100988442, 4986.87532811679, 5007.974960125194, 5081.441041485452, 5099.260607211952, 5048.091343558158, 5055.545000949914, 5078.4921507849285, 5131.461196574362, 5143.691378517301, 4769.284607308897, 4850.830220942268, 4883.462819089933, 4991.425986011583, 5000.524950129732, 4960.851174464736, 4966.230234313687, 4969.875753106165, 4992.425871024842, 5051.989602079562, 4740.715557066553, 4964.429090654585, 4972.0, 4979.7012179268995, 5050.520200580939, 5199.688018718889, 5285.947140528622, 5307.946920530784, 5333.866653333659, 5382.9730851345885, 5951.553633477506, 5960.837636660853, 6013.579049466495, 6014.939850601481, 6031.4270144336215, 5760.53915686744, 5888.322842873082, 6030.396960303979, 6043.335233124353, 6043.456088951972, 5558.638688485235, 5627.493525582676, 5632.183333416631, 5640.5487560995025, 5681.431856814327, 6165.506759459233, 6165.691715414211, 6166.229221347332, 6178.104174894615, 6182.196314479089, 5571.1086226203615, 5724.79963201286, 5917.408259174048, 5944.346121926585, 5954.345022047572, 5682.090865461589, 5736.196932429463, 5751.194832723422, 5752.597318187687, 5758.280214973129, 5888.352281249059, 6015.428534289235, 6023.27720673522, 6024.57827952048, 6070.575059745864, 5927.1405646181065, 5985.970070149709, 5996.16053752475, 5996.580239383201, 6006.12911127884, 4398.956010439854, 4493.887652808706, 4559.316102584573, 4572.108438854458, 4596.678232523691, 4006.959930400717, 4018.557958624549, 4030.435738996543, 4059.878203653895, 4060.675145988314, 5626.465485778845, 5629.240052592848, 5667.1782591524825, 5679.204911312419, 5680.77276908919, 5662.546996240291, 5764.423557644286, 5783.652980821164, 6018.277806663228, 6024.849378765566, 5604.243427137366, 5660.971695141498, 5677.772889084473, 5702.971485142631, 5714.085746280658, 5201.219817027476, 5214.556762675139, 5251.36983561975, 5256.973715131477, 5293.761780719877, 5846.386129456431, 5986.4013598639785, 6051.0, 6130.724117414727, 6135.783919773617, 5942.940570594239, 5985.281766188085, 5993.130996005642, 6033.456988871023, 6058.182145410313, 6074.848128796815, 6120.234970628671, 6134.2332208473945, 6142.508599312134, 6145.201123853871, 5606.6636001840025, 5726.599138060463, 5820.30156381237, 5915.231019967377, 5962.493188079062, 6002.039673652369, 6007.549433792396, 6035.215421995113, 6043.3050199227655, 6063.757449701962, 5549.805756798492, 5891.116332550152, 5896.027155519291, 5911.674857882857, 5926.111083337534, 5662.263905692398, 5676.120201368794, 5709.51469125129, 5710.314762228559, 5714.828555143353, 5560.471755183251, 5604.159376093618, 5617.943820561905, 5634.690092044977, 5654.0, 5823.417658234142, 5847.590668653153, 5867.325257595431, 5882.588218824641, 5895.557833162444, 5378.704171270461, 5611.4949654529655, 5736.139579063174, 5744.080947048452, 5745.971270143623], "unit": "score", "name": "dojo.html", "value": 5454.562024634893}, {"lowerIsBetter": false, "replicates": [560.4871542538577, 607.4532920371666, 607.6627471753178, 611.9418655227752, 612.445736608369, 39018.0, 39377.212455750865, 39579.604203957955, 39587.802060989656, 39710.60289397105, 41826.58173418265, 42035.36946945798, 42210.15579688404, 42342.57657423425, 42343.0, 8651.65393384264, 8727.170918762738, 8761.12388761122, 8769.210771030606, 8802.427842190236, 8540.829183416328, 8684.43551169172, 8737.126287371275, 8743.0, 8744.519051452167, 8655.0, 8656.134386561356, 8704.956475217616, 8713.346499012569, 8719.60761765719, 8662.047174810798, 8682.30541556674, 8714.69498567547, 8724.302055835518, 8762.12378762125, 8561.400701950866, 8647.783805404915, 8675.826483470359, 8678.088800675965, 8710.564471776386, 39782.40326395106, 39945.0, 40070.59929400727, 40093.79953100245, 40225.396619050734, 3270.9509357359657, 3347.6317605063423, 3446.5864096308605, 3462.41139006367, 3604.9098772530633, 28965.0, 29231.41537169266, 29565.55651665227, 29647.5552866705, 29814.254643633867, 3910.9413358799643, 3937.8031098444962, 3961.8217180226957, 4010.7593544387432, 4016.6184212499766, 242098.0, 242345.0, 244772.0, 245650.0, 246194.0, 55117.72441137768, 55617.443825561226, 57008.714956424956, 59343.40656593379, 59909.0, 53407.46592534025, 53416.732916335946, 53459.73270133702, 53518.0, 53549.73225133927, 13503.86496135026, 13697.109687870257, 13713.108647937852, 13720.588382348546, 13765.793513097311, 10317.0, 10325.690229293134, 10349.327293725884, 10365.481725913825, 10398.68803935883, 19261.711074333896, 19265.614687706166, 19291.228350866088, 19342.613147736967, 19370.322038728576, 7381.557106573623, 7593.164751877289, 7619.771406857803, 7629.05230993526, 7656.124249558894, 930.2093220762298, 931.7344556801279, 963.5808423335872, 1026.6817286641017, 1064.7870425914848, 28548.286292842844, 29076.418471630448, 29427.705722942927, 29733.256668583457, 29759.0, 986.2997271937005, 1009.5911155981839, 1022.2588623248234, 1050.6427814543092, 1096.1833434091652, 13819.309034548232, 14363.856361436252, 14480.131192128507, 15305.846941530664, 15574.922125389527, 304267.0, 307151.0, 308501.0, 309030.0, 309608.0, 51419.228711568605, 51505.48494515082, 51541.484585154416, 51546.22680659793, 51729.0, 1301.0957384617789, 1301.557470460048, 1324.317976242236, 1331.9334033298296, 1351.797230415426, 28203.71796282011, 28727.71272287334, 28908.265504069823, 29309.560356595095, 29521.85239073791, 45586.772066139456, 45613.31580026236, 45628.0, 45818.541814581426, 45953.540464594924, 292088.0142790712, 292513.0, 293483.0, 293796.0, 294322.0, 27592.862035689694, 27986.72013279841, 29958.550621740254, 31170.532442012933, 31597.0, 37399.0, 37418.62581374151, 37948.24103517859, 38177.04557385977, 38238.42642360422, 32257.193570160933, 35314.64685353216, 35967.64032359748, 36252.63747362493, 36264.27471450609, 33016.50475242922, 33536.66463335433, 33547.83226083854, 34925.65074349224, 35110.29779404448, 33757.66242337545, 34597.48103778395, 34605.13487162841, 34805.65194348024, 34839.825800870836, 29840.619535348487, 30886.845565772925, 31960.0, 32098.67901320957, 32272.677273227906, 24524.14165504199, 24628.261152165465, 24724.752752472963, 24945.75054249507, 25056.24831255065], "unit": "score", "name": "ext.html", "value": 18015.382397939025}, {"lowerIsBetter": false, "replicates": [365.0162811223753, 365.65993625927877, 365.69464497144867, 366.86976123476165, 372.10137517894293, 16273.267702953366, 17035.829641703578, 17544.82455175448, 17838.28646854126, 18059.458216253533, 15563.68872622547, 15764.211789410541, 15855.60360990973, 15976.121313327762, 16166.83833161668, 4908.042931628325, 4999.700017998914, 5028.547430731233, 5046.44489106198, 5051.621128415365, 4517.412736344287, 4971.353724015891, 5009.949900501003, 5014.222795466709, 5019.222020586797, 5093.694378337312, 5268.1834315680935, 5269.288646032794, 5405.945940540603, 5431.429699881515, 5153.948460515385, 5197.272381866542, 5208.2968799212185, 5219.556337711299, 5220.243064755608, 5258.789648414097, 5262.421133675292, 5265.947340526623, 5271.472852714736, 5277.419483856773, 14735.70528589433, 18725.719114213298, 18797.624047519108, 19210.615787684306, 19265.518362040923, 2034.8473864460225, 2110.767815540289, 2131.1049359269145, 2173.804357607823, 2245.259064508708, 9666.854997175047, 9746.269029822792, 10000.199984001263, 10107.140893024029, 10369.688909332732, 1821.4717731857745, 1863.7483939668107, 1875.7936626971023, 1893.129160586132, 1922.846172306212, 58275.15809391019, 61903.690481547754, 62196.68901655508, 62648.373516264706, 63342.366576334105, 10159.238057145743, 10303.948480257552, 10337.22470814692, 10420.0, 10461.84307235392, 13474.797878031837, 13522.0, 13524.0, 13533.661658458617, 13537.59387218385, 7214.531055481377, 7268.0, 7295.963520182471, 7296.233895441009, 7346.155192152971, 6773.322667733286, 6807.944768560881, 6859.382655560924, 6871.828204294932, 6898.724051037902, 4383.802728877208, 4411.117776444724, 4442.111577684476, 4476.6418686505, 4490.438695163105, 1713.2804222226694, 1871.737956686065, 1888.2635772048911, 1900.3063881683363, 1907.685231936715, 800.0519384529235, 917.7659696777279, 937.3110763588757, 982.6806287956442, 1010.4897027001317, 15575.688486230212, 15577.0, 15976.680466390839, 16631.501054968372, 16936.915315423343, 934.9579268932914, 935.1677007463363, 956.2350119904188, 974.4786539201493, 997.0328781082338, 5862.970685146547, 6041.667708275999, 6203.100550420164, 9278.11857873501, 9796.804063918682, 377918.0, 382569.0, 385504.0, 554865.0, 557580.0, 71170.0, 75058.0, 81498.59250703827, 81778.0, 83313.58343208245, 476.63061127625673, 482.9106615276185, 488.99511004890206, 489.55450540009133, 490.93863267091615, 10169.847452288073, 10344.586216551254, 10547.419891905713, 10578.418186999788, 10678.519466624177, 35162.296754064264, 36315.45526817047, 36334.45498317474, 36680.449793253654, 36756.89729308125, 47448.05103897972, 47952.04095918132, 48849.0, 49294.50705493043, 49797.0, 9559.378640388632, 9578.425294482353, 9672.371295865747, 9679.177269932135, 9767.658131965347, 17057.402990895258, 17063.317467301666, 17800.287988480835, 17949.461516154537, 17963.910180449013, 12139.332336721565, 12511.624651260478, 13761.587152385444, 14805.111693298006, 14971.77542336844, 12872.420741066488, 13019.739605208033, 14825.184614846286, 15386.153761543223, 15510.689786204439, 14773.92613036928, 14823.851761482247, 15082.924585377003, 15241.542753717406, 15283.541493755205, 9729.173020293354, 9747.512624368896, 9953.701388958343, 9955.950220248853, 9966.252531060054, 13718.65703357424, 13728.313584320544, 14290.42838286457, 14344.56966291013, 14876.107433554022], "unit": "score", "name": "jquery.html", "value": 8438.534235501724}, {"lowerIsBetter": false, "replicates": [1452.7385070687276, 1524.5883611424915, 1599.984000159998, 1655.84269494398, 1790.185465613146, 7063.293670632934, 7400.259974002597, 7490.850182996337, 7526.924730752691, 7650.8852367214395, 7372.852542949137, 7378.0, 7411.555306681603, 7421.332080112788, 7428.480006399541, 2288.6681431192424, 2339.7192336919593, 2340.871252081135, 2340.9063637454483, 2343.414146463384, 2285.7714228577174, 2303.1593468384085, 2304.6543018547186, 2305.262316058862, 2351.412146963259, 2171.869687818736, 2229.5095079082575, 2231.419830843976, 2288.336382449088, 2291.862488250702, 2228.3983324502456, 2261.5929132756096, 2305.5734689082487, 2310.1798861404295, 2315.2475445480204, 2240.7423146338056, 2268.0814270220585, 2268.1834539565743, 2269.8184145268337, 2273.3748219239674, 7470.103587569472, 7523.473356865022, 7539.585322807244, 7545.69817207311, 7553.131389890178, 4553.157665831832, 4579.290210017452, 4599.218132917378, 4605.723656580616, 4640.907181856378, 3040.847957602111, 3087.3825234952874, 3113.7664675149226, 3121.344517651296, 3142.874285028596, 986.9225280783918, 994.8855881573639, 1004.2417974429333, 1016.5778861950456, 1069.8234791259433, 10075.899241007643, 10141.898581014242, 10159.7460063499, 10222.744431389201, 10223.846642300372, 4014.116894283253, 4032.495938007749, 4060.5330387005283, 4089.509258888893, 4126.587341265849, 8302.667893284322, 8319.376046796393, 8323.625436855356, 8324.334053275723, 8340.916590834015, 4460.598546130864, 4481.641468682497, 4491.416115904912, 4494.12364588902, 4521.525239849834, 4068.6338229559483, 4091.4272001919753, 4098.364753463218, 4106.096658735073, 4106.342985122366, 3428.3314753623304, 3443.776154549946, 3443.913902152466, 3467.2025434150287, 3480.2517458746493, 1064.1912146768511, 1069.4813015687384, 1074.908632766208, 1077.2082519348273, 1080.7622323088908, 904.8461761500561, 916.7112359606703, 1119.9160062995309, 1121.2711737370773, 1348.3258370814592, 6956.130483689539, 6980.965095174492, 6987.545809522467, 7014.438844892396, 7059.0, 632.2413104274889, 635.8855406026867, 643.6009674002148, 644.9419552240321, 781.8553567589901, 5474.124140137559, 5481.506664400223, 5528.917066244009, 5535.418781028015, 5546.168074788814, 8692.304615630734, 8837.585986242299, 8978.191962723386, 8994.775130621787, 9170.67902623405, 9008.099190081071, 9013.369064165576, 9021.639134434548, 9091.590878410487, 9112.179903808557, 6865.862682746317, 6892.931070689329, 6910.723571057202, 7099.290070992859, 7218.061651985313, 6914.688839002358, 6933.237343892067, 6945.513814032969, 6956.373926346653, 6965.33829286217, 7893.329067029367, 8058.919410805817, 8158.347332213528, 8176.059753128467, 8258.339332853237, 8182.83634327322, 8328.708495202638, 8348.415610907177, 8367.12145224767, 8479.533625650649, 6407.391297826699, 6446.258680251831, 6467.223933128054, 6508.251551071688, 6514.055461958084, 7360.96319518399, 7422.331990120915, 7435.665395057127, 7436.996005539183, 7448.627568621656, 6724.394804467622, 6849.760258390932, 7046.718131274692, 7114.075170228044, 7148.142222933281, 6490.902636460362, 6547.574407663486, 6589.967050164719, 6784.050232967487, 6918.688659010256, 6416.550841441054, 6537.70580323877, 6545.738170473318, 6551.0, 6563.3764792344655, 6066.241719785027, 6073.696315184135, 6074.878502429839, 6112.083187521729, 6121.265448146251, 6063.787767428119, 6068.059450784959, 6084.726187321493, 6104.0, 6156.938430615636], "unit": "score", "name": "mootools.html", "value": 4285.295369326667}, {"lowerIsBetter": false, "replicates": [349.1132523390588, 352.52057202205, 353.1330583417709, 355.1582748885141, 357.5673435143476, 6174.289956654986, 6255.843603909904, 6283.52873534485, 6329.77845775398, 6356.07836863655, 6110.755569777203, 6279.937200627993, 6280.4347608715325, 6282.842928926779, 6353.047042943561, 4813.0, 4844.394450693663, 4849.10291596055, 4850.0, 4861.902761944759, 4843.854684359458, 4847.12751704693, 4859.659823812334, 4874.2688596710595, 4884.438289596688, 4733.171694953387, 4805.783739731703, 4806.327114204014, 4814.66297359185, 4819.7590120494015, 4792.394547826482, 4794.616430685537, 4810.8797280068275, 4816.975915120437, 4826.155422800995, 4199.874003779892, 4207.1165055338415, 4214.789260536961, 4228.0, 4237.343211802145, 5962.34414214436, 6022.247219097613, 6026.337102918676, 6027.126066720345, 6028.125921741323, 5440.972795136038, 5572.749226284827, 5592.105263157875, 5597.132444471114, 5609.046462101453, 6632.734690612369, 6642.136522252076, 6645.867082658319, 6664.300248473889, 6676.866462670768, 4690.59282215334, 4692.1084993851055, 4694.788734506921, 4695.60087392572, 4707.176244157293, 6691.799246022627, 6916.861662766716, 6957.443404527626, 6972.988916607063, 6978.302169782981, 4661.650376221797, 4683.625309975194, 4701.905961880743, 4706.764661766898, 4708.081924024782, 4738.170820106537, 4753.239481682914, 4755.812326329858, 4756.9286460703115, 4765.356676848651, 5531.308586426697, 5535.308086489189, 5539.584531160099, 5554.666719996813, 5556.0, 6567.540272180901, 6725.092112564839, 6729.05793188954, 6731.798046058626, 6732.293109223461, 1648.0935485483176, 1659.0543390267433, 1666.0503512997475, 1675.5978565144278, 1680.7226807576612, 1128.2948157401624, 1134.5802053240354, 1141.8972292493715, 1143.17691262291, 1152.141654467427, 6371.936280637227, 6409.294977552466, 6446.0, 6464.385883341075, 6464.676766161673, 6817.113775209191, 6835.521513494107, 6891.069705589782, 6903.447724182053, 6905.75829845953, 6364.077208804697, 6381.489480841522, 6403.3276505966205, 6433.613983160932, 6439.484841212692, 3770.3967365221984, 3782.3759079751535, 3824.5028146341356, 3833.769973801581, 3846.7307288489537, 7274.672639731225, 7276.963615181996, 7287.380572651384, 7287.526310789782, 7311.634418279064, 7081.645917704094, 7223.891641625275, 7228.602426866572, 7230.855382892312, 7273.418126549864, 7190.280971902873, 7208.459365547605, 7239.420846332281, 7253.984442178099, 7270.781876543606, 6992.650367481708, 7019.052427922369, 7029.121359830021, 7029.715342513601, 7041.119860017498, 6714.0, 6867.862642747217, 6872.347127022925, 6897.689603967934, 6966.059581956371, 7169.426445884213, 7176.390006849476, 7180.60506672138, 7188.5327453715345, 7203.775358189016, 4610.861674149781, 4616.9307460387445, 4631.374764406897, 4635.884102897319, 4645.419322584677, 6808.557443766139, 6844.794656160323, 6921.446284297143, 7000.19497757744, 7030.156381234285, 6801.0, 6824.590524568542, 6825.761098361533, 6846.520743548103, 6851.828704282433, 6768.898466522907, 6793.490488213502, 6799.966000169968, 6819.283975182534, 6824.7952561423235, 6540.363342431085, 6647.734090636513, 6659.600423974383, 6697.598144111369, 6704.195496540447, 6778.93221067783, 6840.521163518506, 6862.897056544056, 6870.484713646397, 6875.312468753084, 6682.799516014527, 6683.598984060972, 6689.8327541809895, 6695.564788288746, 6707.0], "unit": "score", "name": "prototype.html", "value": 5065.768510781951}, {"lowerIsBetter": false, "replicates": [758.457702742539, 802.7190483330833, 804.1315379390255, 829.8506268871605, 860.1011942520066, 13764.655883602902, 14087.50693725721, 14090.225037622926, 14174.433022679106, 14198.645033874145, 13075.673108172277, 13102.213867167977, 13227.537036203736, 13250.933745331284, 13289.401976911038, 837.6733074101105, 854.9059603443616, 856.3021137772695, 856.6530555125184, 858.7166235142388, 851.2849206666399, 859.3211363023236, 860.0410542245382, 860.5912191708951, 860.6858496648741, 893.9106089391041, 898.7753061734567, 898.8067565473422, 900.158351940934, 901.143913282381, 889.328556939513, 894.6019021535419, 895.3911340288602, 895.7178488776015, 896.4845214001975, 650.3593959949446, 654.8133781872191, 655.1613934164277, 655.8458762190882, 656.0814859197114, 13979.860201397958, 13998.30008499571, 14018.22899740524, 14054.578362649137, 14112.71774564503, 11941.402929853473, 12364.319962402064, 12461.837496439755, 12609.684757881034, 12694.80957785634, 10433.895661043369, 10461.843072353844, 10639.840402393971, 10701.732456688645, 10755.408452535108, 3582.17609949713, 3619.4208926571887, 3622.7464077514583, 3637.0, 3658.2866341063504, 42266.1546769066, 44040.77979610081, 44515.33227001598, 44782.552174478165, 44939.55060449387, 9259.212966897754, 9527.237820974306, 10137.746556336151, 10147.64483243083, 10169.898301016896, 17552.122393880254, 17554.38559650406, 17574.82425175732, 17626.823731762775, 17844.286228550973, 7363.263673632594, 7494.700211991569, 7528.811779705442, 7554.2823431773895, 7558.773236802905, 4003.619656132663, 4044.5753195914003, 4061.0647647578116, 4069.2268468990796, 4092.0792821615496, 3086.66046734859, 3105.897406420733, 3116.9844150779554, 3119.5944527211773, 3132.37352529495, 568.6616463204386, 575.5424437572141, 579.1139556478595, 579.8637320229743, 608.3247595169358, 585.5249096611624, 671.3387313496203, 692.3768608252612, 698.9446627616758, 714.9642517874086, 7830.882536761953, 8596.011458682331, 8627.827443451095, 8670.653173873101, 8888.911110888937, 590.9261342332209, 633.4868756307405, 692.882210024287, 694.6422592364936, 718.0270733156602, 3601.603823579404, 3889.202713443737, 4037.989372139481, 4109.363048727452, 4224.239636865394, 55289.72355138279, 55587.0, 55689.44310556923, 55880.16179757307, 56096.43903560994, 49029.26456103161, 49715.0, 50119.74940125349, 51373.22940155901, 51879.0, 40740.0, 45444.772776135906, 45631.08737825225, 45728.54271457243, 45915.54084459179, 8330.0, 8408.87386689188, 8486.74539763808, 8777.297816174818, 8957.955210223907, 35252.29495410026, 35708.821455892554, 35855.46216806698, 36439.81780091082, 36468.635313646526, 39901.201975960896, 39995.60004400035, 43155.136897261254, 45260.09479810319, 45533.54466455293, 10649.840252396065, 10759.193060520336, 10776.0, 10777.0, 10811.837822432513, 11938.552596717826, 12215.816762748389, 12220.75558488843, 12313.753724925631, 12446.315452650191, 10341.896581034094, 10368.410097826481, 10383.792324153626, 10454.790904182026, 10597.046265836112, 10879.619213327496, 11003.724906877393, 11232.7753444929, 11274.887251127384, 11500.712482188012, 9865.309428340235, 9893.159081478156, 10073.19414446857, 10100.949495252476, 10362.171026317727, 9971.152452041657, 10080.495975201356, 10120.291579589359, 10226.6420675276, 10818.242723009314, 8766.254868336007, 8936.687215947411, 9337.253019758538, 9689.273304502332, 9780.902190978284], "unit": "score", "name": "yui.html", "value": 6303.636282325405}], "name": "dromaeo_css", "value": 6958.047387398838}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 113.0, 111.0, 110.0, 123.0, 112.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [147.0, 123.0, 155.0, 167.0, 124.0, 147.0, 153.0, 130.0, 163.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 171.0, 162.0, 160.0, 166.0, 170.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 72.0, 72.0, 73.0, 139.0, 71.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 140.0, 93.0, 93.0, 94.0, 142.0, 94.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 97.0, 100.0, 97.0, 96.0, 95.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [61.0, 71.0, 61.0, 61.0, 64.0, 69.0, 70.0, 61.0, 64.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 64.2}, {"lowerIsBetter": true, "replicates": [68.0, 73.0, 66.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 101.0, 87.0, 93.0, 85.0, 85.0, 84.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 133.0, 117.0, 118.0, 125.0, 131.0, 125.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [147.0, 155.0, 145.0, 155.0, 153.0, 142.0, 169.0, 156.0, 154.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 70.0, 67.0, 68.0, 67.0, 70.0, 73.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1524.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [194.32568985619898], "unit": "score", "name": "DeltaBlue", "value": 340.2432279999999}, {"lowerIsBetter": false, "replicates": [282.9654782116582], "unit": "score", "name": "Encrypt", "value": 940.6836540000003}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [754.7169811320755], "unit": "score", "name": "Earley", "value": 883.0634750000003}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [569.4760820045558], "unit": "score", "name": "Splay", "value": 143.098196}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 21207.346308874156}]} 20:20:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21207.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1524.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6958.05"}}} 20:20:08 INFO - Return code: 0 20:20:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:20:08 INFO - # TBPL SUCCESS # 20:20:08 INFO - Running post-action listener: _resource_record_post_action 20:20:08 INFO - Running post-run listener: _resource_record_post_run 20:20:09 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 567349248; Read time: 16; Write time: 1321492 20:20:09 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 245567488; Read time: 0; Write time: 728388 20:20:09 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321781760; Read time: 16; Write time: 593104 20:20:09 INFO - Running post-run listener: _upload_blobber_files 20:20:09 INFO - Blob upload gear active. 20:20:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:20:09 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:20:09 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:20:09 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:20:10 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:11 INFO - (blobuploader) - INFO - Done attempting. 20:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:12 INFO - (blobuploader) - INFO - Done attempting. 20:20:12 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:12 INFO - Return code: 0 20:20:12 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:20:12 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdb18aa817a4b8674849cd854645da5abd5a7d7ccf44105ecea21eab183fb76f953d99f5d0296a4c87bb7d8c0b04c4e958efa7ee9c1b7dacc13ce4e3f3d05dda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8b29685ff753e1fcee04976a8cfc9641fd73259f927f61079f00bf866f1296a0fe27d25ca51d5b6f1d61f1aa32bfdcb435f0508c1ff77dfe0e7e245fb11c83c"} 20:20:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:20:12 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:20:12 INFO - Contents: 20:20:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdb18aa817a4b8674849cd854645da5abd5a7d7ccf44105ecea21eab183fb76f953d99f5d0296a4c87bb7d8c0b04c4e958efa7ee9c1b7dacc13ce4e3f3d05dda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8b29685ff753e1fcee04976a8cfc9641fd73259f927f61079f00bf866f1296a0fe27d25ca51d5b6f1d61f1aa32bfdcb435f0508c1ff77dfe0e7e245fb11c83c"} 20:20:12 INFO - Copying logs to upload dir... 20:20:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.977488 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 20:20:11.225325) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 20:20:11.228861) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdb18aa817a4b8674849cd854645da5abd5a7d7ccf44105ecea21eab183fb76f953d99f5d0296a4c87bb7d8c0b04c4e958efa7ee9c1b7dacc13ce4e3f3d05dda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8b29685ff753e1fcee04976a8cfc9641fd73259f927f61079f00bf866f1296a0fe27d25ca51d5b6f1d61f1aa32bfdcb435f0508c1ff77dfe0e7e245fb11c83c"} 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.011181 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bdb18aa817a4b8674849cd854645da5abd5a7d7ccf44105ecea21eab183fb76f953d99f5d0296a4c87bb7d8c0b04c4e958efa7ee9c1b7dacc13ce4e3f3d05dda", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8b29685ff753e1fcee04976a8cfc9641fd73259f927f61079f00bf866f1296a0fe27d25ca51d5b6f1d61f1aa32bfdcb435f0508c1ff77dfe0e7e245fb11c83c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 20:20:11.253226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 20:20:11.253561) ========= 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=fc81d3768dcd4b6275e033c4000001b5-1450756113.532813-1433383739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 20:20:11.339492) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 20:20:11.339798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 20:20:11.340081) ========= ========= Total master_lag: 0.24 =========