builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1452531204.5 results: success (0) buildid: 20160111030207 builduid: c2a6138e265c432d90e9d97329ae0549 revision: 6020a4cb41a77a09484c24a5875bb221714c0e6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.495951) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.496617) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.496954) ========= 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=4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006441 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.522221) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.522816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.536608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.537024) ========= 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=4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.586822) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.587130) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.587542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.587833) ========= 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=4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 08:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-11 08:53:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.757766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.758109) ========= 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=4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017733 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.807714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:24.808115) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6020a4cb41a77a09484c24a5875bb221714c0e6a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6020a4cb41a77a09484c24a5875bb221714c0e6a --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=4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 08:53:25,609 truncating revision to first 12 chars 2016-01-11 08:53:25,609 Setting DEBUG logging. 2016-01-11 08:53:25,609 attempt 1/10 2016-01-11 08:53:25,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6020a4cb41a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 08:53:25,918 unpacking tar archive at: mozilla-central-6020a4cb41a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:25.446680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:25.447058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:25.456435) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:25.456859) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 08:53:25.457340) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-11 08:53:25.457662) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:53:26 INFO - MultiFileLogger online at 20160111 08:53:26 in /builds/slave/test-pgo 08:53:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:53:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:53:26 INFO - {'append_to_log': False, 08:53:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:53:26 INFO - 'blob_upload_branch': 'Firefox', 08:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:53:26 INFO - 'branch': 'Firefox', 08:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:26 INFO - 'config_files': ('talos/linux_config.py',), 08:53:26 INFO - 'default_actions': ('clobber', 08:53:26 INFO - 'read-buildbot-config', 08:53:26 INFO - 'download-and-extract', 08:53:26 INFO - 'populate-webroot', 08:53:26 INFO - 'create-virtualenv', 08:53:26 INFO - 'install', 08:53:26 INFO - 'run-tests'), 08:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:26 INFO - 'download_minidump_stackwalk': True, 08:53:26 INFO - 'download_symbols': 'ondemand', 08:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:26 INFO - 'installer_path': 'installer.exe', 08:53:26 INFO - 'log_level': 'info', 08:53:26 INFO - 'log_name': 'talos', 08:53:26 INFO - 'log_to_console': True, 08:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:53:26 INFO - 'opt_config_files': (), 08:53:26 INFO - 'pip_index': False, 08:53:26 INFO - 'sps_profile': False, 08:53:26 INFO - 'sps_profile_interval': 0, 08:53:26 INFO - 'suite': 'dromaeojs', 08:53:26 INFO - 'system_bits': '32', 08:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:26 INFO - 'title': 'talos-linux64-ix-024', 08:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:26 INFO - 'use_talos_json': True, 08:53:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:26 INFO - 'work_dir': 'build'} 08:53:26 INFO - ##### 08:53:26 INFO - ##### Running clobber step. 08:53:26 INFO - ##### 08:53:26 INFO - Running pre-action listener: _resource_record_pre_action 08:53:26 INFO - Running main action method: clobber 08:53:26 INFO - rmtree: /builds/slave/test-pgo/build 08:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:53:26 INFO - Running post-action listener: _resource_record_post_action 08:53:26 INFO - ##### 08:53:26 INFO - ##### Running read-buildbot-config step. 08:53:26 INFO - ##### 08:53:26 INFO - Running pre-action listener: _resource_record_pre_action 08:53:26 INFO - Running main action method: read_buildbot_config 08:53:26 INFO - Using buildbot properties: 08:53:26 INFO - { 08:53:26 INFO - "project": "", 08:53:26 INFO - "product": "firefox", 08:53:26 INFO - "script_repo_revision": "production", 08:53:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:53:26 INFO - "repository": "", 08:53:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:53:26 INFO - "buildid": "20160111030207", 08:53:26 INFO - "stage_platform": "linux64-pgo", 08:53:26 INFO - "basedir": "/builds/slave/test-pgo", 08:53:26 INFO - "nightly_build": "True", 08:53:26 INFO - "buildnumber": 640, 08:53:26 INFO - "slavename": "talos-linux64-ix-024", 08:53:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:53:26 INFO - "platform": "ubuntu64_hw", 08:53:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 08:53:26 INFO - "branch": "mozilla-central", 08:53:26 INFO - "repo_path": "mozilla-central", 08:53:26 INFO - "revision": "6020a4cb41a77a09484c24a5875bb221714c0e6a", 08:53:26 INFO - "pgo_build": "True", 08:53:26 INFO - "builduid": "c2a6138e265c432d90e9d97329ae0549", 08:53:26 INFO - "slavebuilddir": "test" 08:53:26 INFO - } 08:53:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:53:26 INFO - Running post-action listener: _resource_record_post_action 08:53:26 INFO - ##### 08:53:26 INFO - ##### Running download-and-extract step. 08:53:26 INFO - ##### 08:53:26 INFO - Running pre-action listener: _resource_record_pre_action 08:53:26 INFO - Running main action method: download_and_extract 08:53:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:53:26 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')]} 08:53:26 INFO - https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:53:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/test_packages.json 08:53:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/test_packages.json 08:53:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:53:27 INFO - Downloaded 1302 bytes. 08:53:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:53:27 INFO - Using the following test package requirements: 08:53:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:53:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:27 INFO - u'jsshell-linux-x86_64.zip'], 08:53:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:53:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:53:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:53:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:53:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:53:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:53: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')]} 08:53:27 INFO - https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/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 08:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/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 08:53:33 INFO - Downloaded 24028723 bytes. 08:53:33 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 08:53:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:53:33 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 08:53:34 INFO - Return code: 0 08:53:34 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 08:53:34 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')]} 08:53:34 INFO - https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/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 08:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/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 08:53:40 INFO - Downloaded 24028723 bytes. 08:53:40 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 08:53:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:53:40 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 08:53:42 INFO - Return code: 0 08:53:42 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')]} 08:53:42 INFO - https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/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 08:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/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 08:53:44 INFO - Downloaded 11132285 bytes. 08:53:44 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 08:53:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:44 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 08:53:44 INFO - Return code: 0 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:44 INFO - https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/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 08:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RfIHTbiyTCaYyUhc8EN6xg/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 08:53:55 INFO - Downloaded 55934765 bytes. 08:53:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:53:55 INFO - mkdir: /builds/slave/test-pgo/properties 08:53:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:53:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:53:55 INFO - Contents: 08:53:55 INFO - build_url:https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:53:55 INFO - Running post-action listener: _resource_record_post_action 08:53:55 INFO - Running post-action listener: set_extra_try_arguments 08:53:55 INFO - ##### 08:53:55 INFO - ##### Running populate-webroot step. 08:53:55 INFO - ##### 08:53:55 INFO - Running pre-action listener: _resource_record_pre_action 08:53:55 INFO - Running main action method: populate_webroot 08:53:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:55 INFO - '--tppagecycles', 08:53:55 INFO - '7'], 08:53:55 INFO - 'tests': ['tsvgm']}}, 08:53:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:53:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:53:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:53:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:55 INFO - 'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:55 INFO - 'tests': ['damp', 'tps']}, 08:53:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:55 INFO - 'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['damp', 'tps']}, 08:53:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:53:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:55 INFO - 'other': {'tests': ['a11yr', 08:53:55 INFO - 'ts_paint', 08:53:55 INFO - 'tpaint', 08:53:55 INFO - 'sessionrestore', 08:53:55 INFO - 'sessionrestore_no_auto_restore']}, 08:53:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['a11yr', 08:53:55 INFO - 'ts_paint', 08:53:55 INFO - 'tpaint', 08:53:55 INFO - 'sessionrestore', 08:53:55 INFO - 'sessionrestore_no_auto_restore']}, 08:53:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['a11yr', 08:53:55 INFO - 'ts_paint', 08:53:55 INFO - 'tpaint', 08:53:55 INFO - 'sessionrestore', 08:53:55 INFO - 'sessionrestore_no_auto_restore']}, 08:53:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['a11yr', 08:53:55 INFO - 'ts_paint', 08:53:55 INFO - 'tpaint', 08:53:55 INFO - 'sessionrestore', 08:53:55 INFO - 'sessionrestore_no_auto_restore']}, 08:53:55 INFO - 'other_l64': {'tests': ['a11yr', 08:53:55 INFO - 'ts_paint', 08:53:55 INFO - 'tpaint', 08:53:55 INFO - 'sessionrestore', 08:53:55 INFO - 'sessionrestore_no_auto_restore']}, 08:53:55 INFO - 'other_nol64': {'tests': ['a11yr', 08:53:55 INFO - 'ts_paint', 08:53:55 INFO - 'tpaint', 08:53:55 INFO - 'sessionrestore', 08:53:55 INFO - 'sessionrestore_no_auto_restore']}, 08:53:55 INFO - 'svgr': {'tests': ['tsvgx', 08:53:55 INFO - 'tsvgr_opacity', 08:53:55 INFO - 'tart', 08:53:55 INFO - 'tscrollx', 08:53:55 INFO - 'cart']}, 08:53:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['tsvgx', 08:53:55 INFO - 'tsvgr_opacity', 08:53:55 INFO - 'tart', 08:53:55 INFO - 'tscrollx', 08:53:55 INFO - 'cart']}, 08:53:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:55 INFO - 'tests': ['tp5o']}, 08:53:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:55 INFO - 'talos_options': ['--e10s'], 08:53:55 INFO - 'tests': ['tp5o']}, 08:53:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:55 INFO - 'talos_options': ['--xperf_path', 08:53:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:55 INFO - 'tests': ['tp5n']}, 08:53:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:55 INFO - 'talos_options': ['--e10s', 08:53:55 INFO - '--xperf_path', 08:53:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:55 INFO - 'tests': ['tp5n']}}, 08:53:55 INFO - 'talos.zip': {'path': '', 08:53:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:55 INFO - Running post-action listener: _resource_record_post_action 08:53:55 INFO - ##### 08:53:55 INFO - ##### Running create-virtualenv step. 08:53:55 INFO - ##### 08:53:55 INFO - Running pre-action listener: _resource_record_pre_action 08:53:55 INFO - Running main action method: create_virtualenv 08:53:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:53:55 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 08:53:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:53:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:56 INFO - Using real prefix '/usr' 08:53:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:53:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:58 INFO - Installing pip.................done. 08:53:58 INFO - Return code: 0 08:53:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:53: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')]} 08:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:53:58 INFO - Using env: {'DISPLAY': ':0', 08:53:58 INFO - 'HOME': '/home/cltbld', 08:53:58 INFO - 'LANG': 'en_US.UTF-8', 08:53:58 INFO - 'LANGUAGE': 'en_US:en', 08:53:58 INFO - 'LOGNAME': 'cltbld', 08:53:58 INFO - 'MAIL': '/var/mail/cltbld', 08:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:58 INFO - 'MOZ_NO_REMOTE': '1', 08:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:58 INFO - 'NO_EM_RESTART': '1', 08:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:53:58 INFO - 'SHELL': '/bin/bash', 08:53:58 INFO - 'SHLVL': '1', 08:53:58 INFO - 'TERM': 'linux', 08:53:58 INFO - 'TMOUT': '86400', 08:53:58 INFO - 'USER': 'cltbld', 08:53:58 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:58 INFO - '_': '/tools/buildbot/bin/python'} 08:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:58 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 08:53:58 INFO - Cleaning up... 08:53:58 INFO - Return code: 0 08:53:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:53: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')]} 08:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:53:58 INFO - Using env: {'DISPLAY': ':0', 08:53:58 INFO - 'HOME': '/home/cltbld', 08:53:58 INFO - 'LANG': 'en_US.UTF-8', 08:53:58 INFO - 'LANGUAGE': 'en_US:en', 08:53:58 INFO - 'LOGNAME': 'cltbld', 08:53:58 INFO - 'MAIL': '/var/mail/cltbld', 08:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:58 INFO - 'MOZ_NO_REMOTE': '1', 08:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:58 INFO - 'NO_EM_RESTART': '1', 08:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:53:58 INFO - 'SHELL': '/bin/bash', 08:53:58 INFO - 'SHLVL': '1', 08:53:58 INFO - 'TERM': 'linux', 08:53:58 INFO - 'TMOUT': '86400', 08:53:58 INFO - 'USER': 'cltbld', 08:53:58 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:58 INFO - '_': '/tools/buildbot/bin/python'} 08:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:58 INFO - Downloading/unpacking psutil>=0.7.1 08:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:54:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:00 INFO - Installing collected packages: psutil 08:54:00 INFO - Running setup.py install for psutil 08:54:00 INFO - building 'psutil._psutil_linux' extension 08:54:00 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 08:54:00 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 08:54:01 INFO - building 'psutil._psutil_posix' extension 08:54:01 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 08:54:01 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 08:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:01 INFO - Successfully installed psutil 08:54:01 INFO - Cleaning up... 08:54:01 INFO - Return code: 0 08:54:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:01 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 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:54:01 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 08:54:01 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 08:54:01 INFO - Using env: {'DISPLAY': ':0', 08:54:01 INFO - 'HOME': '/home/cltbld', 08:54:01 INFO - 'LANG': 'en_US.UTF-8', 08:54:01 INFO - 'LANGUAGE': 'en_US:en', 08:54:01 INFO - 'LOGNAME': 'cltbld', 08:54:01 INFO - 'MAIL': '/var/mail/cltbld', 08:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:01 INFO - 'MOZ_NO_REMOTE': '1', 08:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:01 INFO - 'NO_EM_RESTART': '1', 08:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:01 INFO - 'SHELL': '/bin/bash', 08:54:01 INFO - 'SHLVL': '1', 08:54:01 INFO - 'TERM': 'linux', 08:54:01 INFO - 'TMOUT': '86400', 08:54:01 INFO - 'USER': 'cltbld', 08:54:01 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:01 INFO - '_': '/tools/buildbot/bin/python'} 08:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:54:03 INFO - Installing collected packages: mozsystemmonitor 08:54:03 INFO - Running setup.py install for mozsystemmonitor 08:54:03 INFO - Successfully installed mozsystemmonitor 08:54:03 INFO - Cleaning up... 08:54:03 INFO - Return code: 0 08:54:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:54:03 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')]} 08:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:03 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')]} 08:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:03 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 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:54:03 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 08:54:03 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 08:54:03 INFO - Using env: {'DISPLAY': ':0', 08:54:03 INFO - 'HOME': '/home/cltbld', 08:54:03 INFO - 'LANG': 'en_US.UTF-8', 08:54:03 INFO - 'LANGUAGE': 'en_US:en', 08:54:03 INFO - 'LOGNAME': 'cltbld', 08:54:03 INFO - 'MAIL': '/var/mail/cltbld', 08:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:03 INFO - 'MOZ_NO_REMOTE': '1', 08:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:03 INFO - 'NO_EM_RESTART': '1', 08:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:03 INFO - 'SHELL': '/bin/bash', 08:54:03 INFO - 'SHLVL': '1', 08:54:03 INFO - 'TERM': 'linux', 08:54:03 INFO - 'TMOUT': '86400', 08:54:03 INFO - 'USER': 'cltbld', 08:54:03 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:03 INFO - '_': '/tools/buildbot/bin/python'} 08:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:54:03 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 08:54:03 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 08:54:03 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 08:54:03 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 08:54:03 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 08:54:03 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 08:54:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:54:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:05 INFO - Downloading docopt-0.6.1.tar.gz 08:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:06 INFO - Running setup.py install for blobuploader 08:54:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:54:06 INFO - Running setup.py install for requests 08:54:06 INFO - Running setup.py install for docopt 08:54:06 INFO - Successfully installed blobuploader requests docopt 08:54:06 INFO - Cleaning up... 08:54:06 INFO - Return code: 0 08:54:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:06 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 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:54:06 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 08:54:06 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 08:54:06 INFO - Using env: {'DISPLAY': ':0', 08:54:06 INFO - 'HOME': '/home/cltbld', 08:54:06 INFO - 'LANG': 'en_US.UTF-8', 08:54:06 INFO - 'LANGUAGE': 'en_US:en', 08:54:06 INFO - 'LOGNAME': 'cltbld', 08:54:06 INFO - 'MAIL': '/var/mail/cltbld', 08:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:06 INFO - 'MOZ_NO_REMOTE': '1', 08:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:06 INFO - 'NO_EM_RESTART': '1', 08:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:06 INFO - 'SHELL': '/bin/bash', 08:54:06 INFO - 'SHLVL': '1', 08:54:06 INFO - 'TERM': 'linux', 08:54:06 INFO - 'TMOUT': '86400', 08:54:06 INFO - 'USER': 'cltbld', 08:54:06 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:06 INFO - '_': '/tools/buildbot/bin/python'} 08:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:54:06 INFO - Running setup.py (path:/tmp/pip-Q81KFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:54:06 INFO - Running setup.py (path:/tmp/pip-H9hUd4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:54:06 INFO - Running setup.py (path:/tmp/pip-CUrqdw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:54:07 INFO - Running setup.py (path:/tmp/pip-9J64kY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:54:07 INFO - Running setup.py (path:/tmp/pip-zkJ93R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:54:07 INFO - Running setup.py (path:/tmp/pip-fRzJje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:54:07 INFO - Running setup.py (path:/tmp/pip-Etq77c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:54:07 INFO - Running setup.py (path:/tmp/pip-MZNeyY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:54:07 INFO - Running setup.py (path:/tmp/pip-I4BPfK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:54:07 INFO - Running setup.py (path:/tmp/pip-LTSoIP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:54:07 INFO - Running setup.py (path:/tmp/pip-1Q_Tts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:54:07 INFO - Running setup.py (path:/tmp/pip-GZMv9d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:54:07 INFO - Running setup.py (path:/tmp/pip-Q2TEnJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:54:07 INFO - Running setup.py (path:/tmp/pip-bt5_pi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:54:07 INFO - Running setup.py (path:/tmp/pip-0E4SWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:54:07 INFO - Running setup.py (path:/tmp/pip-uSsn8W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:54:08 INFO - Running setup.py (path:/tmp/pip-75tyPQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:54:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:08 INFO - Running setup.py install for manifestparser 08:54:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Running setup.py install for mozcrash 08:54:08 INFO - Running setup.py install for mozdebug 08:54:08 INFO - Running setup.py install for mozdevice 08:54:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Running setup.py install for mozfile 08:54:08 INFO - Running setup.py install for mozhttpd 08:54:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Running setup.py install for mozinfo 08:54:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Running setup.py install for mozInstall 08:54:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:54:08 INFO - Running setup.py install for mozleak 08:54:08 INFO - Running setup.py install for mozlog 08:54:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:54:09 INFO - Running setup.py install for moznetwork 08:54:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:54:09 INFO - Running setup.py install for mozprocess 08:54:09 INFO - Running setup.py install for mozprofile 08:54:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:54:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:54:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:54:09 INFO - Running setup.py install for mozrunner 08:54:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:54:09 INFO - Running setup.py install for mozscreenshot 08:54:09 INFO - Running setup.py install for moztest 08:54:09 INFO - Running setup.py install for mozversion 08:54:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:54:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:09 INFO - Cleaning up... 08:54:09 INFO - Return code: 0 08:54:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:54:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 08:54:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 08:54:09 INFO - Using env: {'DISPLAY': ':0', 08:54:09 INFO - 'HOME': '/home/cltbld', 08:54:09 INFO - 'LANG': 'en_US.UTF-8', 08:54:09 INFO - 'LANGUAGE': 'en_US:en', 08:54:09 INFO - 'LOGNAME': 'cltbld', 08:54:09 INFO - 'MAIL': '/var/mail/cltbld', 08:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:09 INFO - 'MOZ_NO_REMOTE': '1', 08:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:09 INFO - 'NO_EM_RESTART': '1', 08:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:09 INFO - 'SHELL': '/bin/bash', 08:54:09 INFO - 'SHLVL': '1', 08:54:09 INFO - 'TERM': 'linux', 08:54:09 INFO - 'TMOUT': '86400', 08:54:09 INFO - 'USER': 'cltbld', 08:54:09 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:09 INFO - '_': '/tools/buildbot/bin/python'} 08:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:54:10 INFO - Running setup.py (path:/tmp/pip-8ewbgb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:54:10 INFO - Running setup.py (path:/tmp/pip-Ft0U5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:54:10 INFO - Running setup.py (path:/tmp/pip-pfcT6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:54:10 INFO - Running setup.py (path:/tmp/pip-ALlxeY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:54:10 INFO - Running setup.py (path:/tmp/pip-cEnkjH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:54:10 INFO - Running setup.py (path:/tmp/pip-UeiWpl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:54:10 INFO - Running setup.py (path:/tmp/pip-5fWaQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:54:10 INFO - Running setup.py (path:/tmp/pip-5HDQyn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:54:10 INFO - Running setup.py (path:/tmp/pip-jtGlnh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:54:10 INFO - Running setup.py (path:/tmp/pip-CDJv9b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:54:10 INFO - Running setup.py (path:/tmp/pip-FVG3hh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:54:10 INFO - Running setup.py (path:/tmp/pip-zhAXtl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:54:10 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)) 08:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:54:10 INFO - Running setup.py (path:/tmp/pip-CpO7y_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:54:11 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)) 08:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:54:11 INFO - Running setup.py (path:/tmp/pip-QIw5eW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:54:11 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)) 08:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:54:11 INFO - Running setup.py (path:/tmp/pip-ZXw8uq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:54:11 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)) 08:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:54:11 INFO - Running setup.py (path:/tmp/pip-iNNJxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:54:11 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)) 08:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:54:11 INFO - Running setup.py (path:/tmp/pip-3wg07C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:54:11 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)) 08:54:11 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)) 08:54:11 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)) 08:54:11 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)) 08:54:11 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)) 08:54:11 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)) 08:54:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:13 INFO - Downloading blessings-1.5.1.tar.gz 08:54:13 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 08:54:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:13 INFO - Installing collected packages: blessings 08:54:13 INFO - Running setup.py install for blessings 08:54:13 INFO - Successfully installed blessings 08:54:13 INFO - Cleaning up... 08:54:13 INFO - Return code: 0 08:54:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:54:13 INFO - Reading from file tmpfile_stdout 08:54:13 INFO - Current package versions: 08:54:13 INFO - argparse == 1.2.1 08:54:13 INFO - blessings == 1.5.1 08:54:13 INFO - blobuploader == 1.2.4 08:54:13 INFO - docopt == 0.6.1 08:54:13 INFO - manifestparser == 1.1 08:54:13 INFO - mozInstall == 1.12 08:54:13 INFO - mozcrash == 0.16 08:54:13 INFO - mozdebug == 0.1 08:54:13 INFO - mozdevice == 0.47 08:54:13 INFO - mozfile == 1.2 08:54:13 INFO - mozhttpd == 0.7 08:54:13 INFO - mozinfo == 0.9 08:54:13 INFO - mozleak == 0.1 08:54:13 INFO - mozlog == 3.1 08:54:13 INFO - moznetwork == 0.27 08:54:13 INFO - mozprocess == 0.22 08:54:13 INFO - mozprofile == 0.28 08:54:13 INFO - mozrunner == 6.11 08:54:13 INFO - mozscreenshot == 0.1 08:54:13 INFO - mozsystemmonitor == 0.0 08:54:13 INFO - moztest == 0.7 08:54:13 INFO - mozversion == 1.4 08:54:13 INFO - psutil == 3.1.1 08:54:13 INFO - requests == 1.2.3 08:54:13 INFO - wsgiref == 0.1.2 08:54:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:54:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 08:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 08:54:13 INFO - Using env: {'DISPLAY': ':0', 08:54:13 INFO - 'HOME': '/home/cltbld', 08:54:13 INFO - 'LANG': 'en_US.UTF-8', 08:54:13 INFO - 'LANGUAGE': 'en_US:en', 08:54:13 INFO - 'LOGNAME': 'cltbld', 08:54:13 INFO - 'MAIL': '/var/mail/cltbld', 08:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:13 INFO - 'MOZ_NO_REMOTE': '1', 08:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:13 INFO - 'NO_EM_RESTART': '1', 08:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:13 INFO - 'SHELL': '/bin/bash', 08:54:13 INFO - 'SHLVL': '1', 08:54:13 INFO - 'TERM': 'linux', 08:54:13 INFO - 'TMOUT': '86400', 08:54:13 INFO - 'USER': 'cltbld', 08:54:13 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:13 INFO - '_': '/tools/buildbot/bin/python'} 08:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 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)) 08:54:13 INFO - Cleaning up... 08:54:13 INFO - Return code: 0 08:54:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:54:13 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 08:54:13 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 08:54:13 INFO - Using env: {'DISPLAY': ':0', 08:54:13 INFO - 'HOME': '/home/cltbld', 08:54:13 INFO - 'LANG': 'en_US.UTF-8', 08:54:13 INFO - 'LANGUAGE': 'en_US:en', 08:54:13 INFO - 'LOGNAME': 'cltbld', 08:54:13 INFO - 'MAIL': '/var/mail/cltbld', 08:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:13 INFO - 'MOZ_NO_REMOTE': '1', 08:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:13 INFO - 'NO_EM_RESTART': '1', 08:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:13 INFO - 'SHELL': '/bin/bash', 08:54:13 INFO - 'SHLVL': '1', 08:54:13 INFO - 'TERM': 'linux', 08:54:13 INFO - 'TMOUT': '86400', 08:54:13 INFO - 'USER': 'cltbld', 08:54:13 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:13 INFO - '_': '/tools/buildbot/bin/python'} 08:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:13 INFO - Downloading/unpacking jsonschema 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:54:15 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 08:54:15 INFO - Downloading/unpacking functools32 (from jsonschema) 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:54:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:54:16 INFO - warning: no files found matching '*.txt' 08:54:16 INFO - no previously-included directories found matching 'build' 08:54:16 INFO - no previously-included directories found matching 'dist' 08:54:16 INFO - no previously-included directories found matching '.git*' 08:54:16 INFO - Installing collected packages: jsonschema, functools32 08:54:16 INFO - Running setup.py install for functools32 08:54:16 INFO - warning: no files found matching '*.txt' 08:54:16 INFO - no previously-included directories found matching 'build' 08:54:16 INFO - no previously-included directories found matching 'dist' 08:54:16 INFO - no previously-included directories found matching '.git*' 08:54:16 INFO - Successfully installed jsonschema functools32 08:54:16 INFO - Cleaning up... 08:54:16 INFO - Return code: 0 08:54:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:54:16 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')]} 08:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:16 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')]} 08:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:16 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 0x7f9766370f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd5f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, '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': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', '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 08:54:16 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 08:54:16 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 08:54:16 INFO - Using env: {'DISPLAY': ':0', 08:54:16 INFO - 'HOME': '/home/cltbld', 08:54:16 INFO - 'LANG': 'en_US.UTF-8', 08:54:16 INFO - 'LANGUAGE': 'en_US:en', 08:54:16 INFO - 'LOGNAME': 'cltbld', 08:54:16 INFO - 'MAIL': '/var/mail/cltbld', 08:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:16 INFO - 'MOZ_NO_REMOTE': '1', 08:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:16 INFO - 'NO_EM_RESTART': '1', 08:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:16 INFO - 'SHELL': '/bin/bash', 08:54:16 INFO - 'SHLVL': '1', 08:54:16 INFO - 'TERM': 'linux', 08:54:16 INFO - 'TMOUT': '86400', 08:54:16 INFO - 'USER': 'cltbld', 08:54:16 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:16 INFO - '_': '/tools/buildbot/bin/python'} 08:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:16 INFO - Downloading/unpacking flake8 08:54:16 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 08:54:16 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 08:54:16 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 08:54:16 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 08:54:16 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 08:54:16 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 08:54:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:54:18 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 08:54:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:54:18 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 08:54:18 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 08:54:18 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 08:54:18 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 08:54:18 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 08:54:18 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 08:54:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:54:18 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 08:54:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:54:18 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 08:54:18 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 08:54:18 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 08:54:18 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 08:54:18 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 08:54:18 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 08:54:19 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 08:54:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:54:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:54:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:54:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:54:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:54:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:54:19 INFO - no previously-included directories found matching 'docs/_build' 08:54:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:54:19 INFO - Running setup.py install for pep8 08:54:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:54:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:54:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:54:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:54:19 INFO - no previously-included directories found matching 'docs/_build' 08:54:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:54:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:54:19 INFO - Cleaning up... 08:54:19 INFO - Return code: 0 08:54:19 INFO - Running post-action listener: _resource_record_post_action 08:54:19 INFO - Running post-action listener: _start_resource_monitoring 08:54:19 INFO - Starting resource monitoring. 08:54:19 INFO - ##### 08:54:19 INFO - ##### Running install step. 08:54:19 INFO - ##### 08:54:19 INFO - Running pre-action listener: _resource_record_pre_action 08:54:19 INFO - Running main action method: install 08:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:54:19 INFO - Reading from file tmpfile_stdout 08:54:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:54:19 INFO - Reading from file tmpfile_stdout 08:54:19 INFO - Output received: 08:54:19 INFO - Usage: mozinstall [options] installer 08:54:19 INFO - Options: 08:54:19 INFO - -h, --help show this help message and exit 08:54:19 INFO - -d DEST, --destination=DEST 08:54:19 INFO - Directory to install application into. [default: 08:54:19 INFO - "/builds/slave/test-pgo"] 08:54:19 INFO - --app=APP Application being installed. [default: firefox] 08:54:19 INFO - mkdir: /builds/slave/test-pgo/build/application 08:54:19 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'] 08:54:19 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 08:54:35 INFO - Reading from file tmpfile_stdout 08:54:35 INFO - Output received: 08:54:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:54:35 INFO - Running post-action listener: _resource_record_post_action 08:54:35 INFO - ##### 08:54:35 INFO - ##### Running run-tests step. 08:54:35 INFO - ##### 08:54:35 INFO - Running pre-action listener: _resource_record_pre_action 08:54:35 INFO - Running main action method: run_tests 08:54:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:54:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:54:35 INFO - Python 2.7.3 08:54:35 INFO - Return code: 0 08:54:35 INFO - grabbing minidump binary from tooltool 08:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:35 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 0xdf0840>, '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 0xd5d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd5db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:54:35 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 08:54:35 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 08:54:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:36 INFO - Return code: 0 08:54:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:54:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:54:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:54:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:54:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:54:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:54:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:54:37 INFO - Return code: 0 08:54:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:54:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:54:37 INFO - Using env: {'DISPLAY': ':0', 08:54:37 INFO - 'HOME': '/home/cltbld', 08:54:37 INFO - 'LANG': 'en_US.UTF-8', 08:54:37 INFO - 'LANGUAGE': 'en_US:en', 08:54:37 INFO - 'LOGNAME': 'cltbld', 08:54:37 INFO - 'MAIL': '/var/mail/cltbld', 08:54:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:54:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:37 INFO - 'MOZ_NO_REMOTE': '1', 08:54:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:37 INFO - 'NO_EM_RESTART': '1', 08:54:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:54:37 INFO - 'PWD': '/builds/slave/test-pgo', 08:54:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:54:37 INFO - 'SHELL': '/bin/bash', 08:54:37 INFO - 'SHLVL': '1', 08:54:37 INFO - 'TERM': 'linux', 08:54:37 INFO - 'TMOUT': '86400', 08:54:37 INFO - 'USER': 'cltbld', 08:54:37 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692', 08:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:37 INFO - '_': '/tools/buildbot/bin/python'} 08:54:37 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:54:37 INFO - mozversion application_buildid: 20160111030207 08:54:37 INFO - mozversion application_changeset: 6020a4cb41a77a09484c24a5875bb221714c0e6a 08:54:37 INFO - mozversion application_display_name: Nightly 08:54:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:37 INFO - mozversion application_name: Firefox 08:54:37 INFO - mozversion application_remotingname: firefox 08:54:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:54:37 INFO - mozversion application_vendor: Mozilla 08:54:37 INFO - mozversion application_version: 46.0a1 08:54:37 INFO - mozversion platform_buildid: 20160111030207 08:54:37 INFO - mozversion platform_changeset: 6020a4cb41a77a09484c24a5875bb221714c0e6a 08:54:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:54:37 INFO - mozversion platform_version: 46.0a1 08:54:37 INFO - using testdate: 1452531277 08:54:37 INFO - actual date: 1452531277 08:54:37 INFO - starting webserver on 'localhost:37726' 08:54:37 INFO - SUITE-START | Running 3 tests 08:54:37 INFO - TEST-START | dromaeo_css 08:54:37 INFO - operating with platform_type : linux_ 08:54:37 INFO - Initialising browser for dromaeo_css test... 08:54:37 INFO - TEST-INFO | started process 433 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2nr8Ia/profile http://localhost:37726/getInfo.html) 08:54:41 INFO - PROCESS | 433 | __metrics Screen width/height:1600/1200 08:54:41 INFO - PROCESS | 433 | colorDepth:24 08:54:41 INFO - PROCESS | 433 | Browser inner width/height: 1024/697 08:54:41 INFO - PROCESS | 433 | __metrics 08:54:41 INFO - PROCESS | 433 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:54:41 INFO - PROCESS | 433 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:42 INFO - TEST-INFO | 433: exit 0 08:54:42 INFO - Browser initialized. 08:54:42 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:42 INFO - TEST-INFO | started process 524 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2nr8Ia/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:53 INFO - PROCESS | 524 | RSS: Main: 148680704 08:54:53 INFO - PROCESS | 524 | 08:55:45 INFO - PROCESS | 524 | 1452531345154 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] 08:57:53 INFO - PROCESS | 524 | Cycle 1(1): loaded http://localhost:37726/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37726/tests/dromaeo/cssquery-ext.html) 08:57:54 INFO - PROCESS | 524 | RSS: Main: 259526656 08:57:54 INFO - PROCESS | 524 | 09:00:56 INFO - PROCESS | 524 | Cycle 1(1): loaded http://localhost:37726/tests/dromaeo/cssquery-ext.html (next: http://localhost:37726/tests/dromaeo/cssquery-jquery.html) 09:00:57 INFO - PROCESS | 524 | RSS: Main: 230920192 09:00:57 INFO - PROCESS | 524 | 09:03:59 INFO - PROCESS | 524 | Cycle 1(1): loaded http://localhost:37726/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37726/tests/dromaeo/cssquery-mootools.html) 09:03:59 INFO - PROCESS | 524 | RSS: Main: 255549440 09:03:59 INFO - PROCESS | 524 | 09:07:01 INFO - PROCESS | 524 | Cycle 1(1): loaded http://localhost:37726/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37726/tests/dromaeo/cssquery-prototype.html) 09:07:02 INFO - PROCESS | 524 | RSS: Main: 211677184 09:07:02 INFO - PROCESS | 524 | 09:10:04 INFO - PROCESS | 524 | Cycle 1(1): loaded http://localhost:37726/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37726/tests/dromaeo/cssquery-yui.html) 09:10:05 INFO - PROCESS | 524 | RSS: Main: 214863872 09:10:05 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | Cycle 1(1): loaded http://localhost:37726/tests/dromaeo/cssquery-yui.html (next: http://localhost:37726/tests/dromaeo/cssquery-dojo.html) 09:13:08 INFO - PROCESS | 524 | RSS: Main: 257413120 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | __start_tp_report 09:13:08 INFO - PROCESS | 524 | _x_x_mozilla_page_load 09:13:08 INFO - PROCESS | 524 | _x_x_mozilla_page_load_details 09:13:08 INFO - PROCESS | 524 | |i|pagename|runs| 09:13:08 INFO - PROCESS | 524 | |0;dojo.html;3109.595752552168;3157.794743341681;3199.936001279973;3203.711665950064;3230.741540676746;4866.756662166887;5023.120953833083;5047.621428392871;5085.466026067261;5138.845834624958;5008.298838162651;5015.4984501549825;5055.924161137576;5067.138586440305;5123.052235336456;4435.645148388137;4571.131485017852;4629.629629629639;4677.789499472515;4840.878978025542;4521.638268938494;4710;4737.336772851803;4767.380240568721;4797.18447863864;4592.150452166343;4610.861674149764;4664.930026049612;4698.177818881699;4723.244280915072;4587.747673877935;4594.2419500782335;4594.65540084495;4595.931061034087;4645.674802763808;4558.8632341029825;4573.474050484204;4578.244589642705;4602.746848923308;4608.516105808875;4832.661713680044;4840.854774356775;4909.8772530686665;4917.016596680678;4943.209086546171;5344;5351.2240725095035;5357.035733567956;5364.490373414558;5365.08793505105;5388.703621300827;5406.783728650849;5411.485908838654;5412.458754124556;5472.452754724535;4924.80300787968;5012.523810238022;5081.79672813087;5186.611004174702;5209.739513024334;5582.190582365615;5589.441055894459;5596.888062238732;5603.047481928082;5646.2942132233475;5348.1442969124755;5374.48942350476;5374.838754837361;5376.7042812644895;5380.166074258496;5329.413764485904;5356.303680521585;5447.046766815792;5474.0146773580345;5483.095289277225;5420.186971954238;5450.8909821803345;5453;5455.399906010336;5460.781568737286;5444.8094316698725;5447.101228297287;5449.727513624303;5454.181872719124;5458.1266997280245;4192.580741925844;4207.410962465257;4272.252355837716;4273.658107351404;4274.615284624399;3837;3841.0013396517106;3848.191879705237;3864.7681139131178;3878.3600705883214;5054.646174767805;5064.518870707277;5065.366829146356;5071.467495912876;5089.821856235014;5259.658122222043;5323.3079699639575;5335.33308336458;5440.537554307849;5456.972715136399;4905.3132561441425;4988.6009119270375;5016.44819069902;5044.1677123274985;5056.469070747518;4610.631149508098;4616.815327386934;4625.930611040837;4628.490866004737;4709.670323077352;5290.656107353087;5353.625246232727;5483.945160548423;5488.506034456918;5534.418886016911;5282.947170528246;5341.3857406398765;5353.170258609922;5356.785728570813;5378.650387724785;5357.276767636475;5359.330083739533;5359.705216213146;5361.731913404392;5380.542653874464;5132.666376685504;5187.98834227322;5271.525562699376;5297.655652382583;5390.946090539202;5282.049231138279;5313.601479888946;5440.455954404528;5441.238226648352;5488;5310.309659744208;5320.042392369411;5336.893262134813;5340.813071542478;5342.332208473941;5204.765785539584;5259.289995850511;5310.176922577007;5311.814086506954;5354;5095.617828662791;5236.659617124875;5294.708791016377;5300.681959082467;5339.225812257123;5304.443033481583;5310.336207974004;5340.465953404629;5343.118385466354;5399.5950303726595;5063.113955057924;5146.794128234828;5231.89536209266;5238.188080847474;5242.842714718565 09:13:08 INFO - PROCESS | 524 | |1;ext.html;550.3863192540318;581.909803980383;597.6862147372628;601.2364297342375;605.5458406195354;27725.445491090166;28335.149945501642;32530.837345813266;32853.34293314132;32899.50650740241;38259;38747.806260968726;38868.222635547274;38875;38954;8391.076981532042;8514.744557663249;8575.871361929576;8578.828423431527;8591.35564832637;8352.791180220482;8474.23731864132;8498.19267169621;8505.234528892399;8514.70198543051;8603.655853765842;8628.223459888608;8694.608742606566;8700.825983480327;8702.608382622766;8617.870731939025;8637.611307491177;8690.174433428814;8701;8705.869411958794;8494.277986371166;8634.481931084156;8650.178233067849;8658.437201581877;8661.393702440831;38012.23975520474;38563.75798662145;38594;38674.41988370177;38675.61324386748;3360.1935535471557;3399.7960122392738;3410.7271418286477;3508.491268766015;3518.5074089627215;28975.42049159026;29348;29372.8531357344;29618.111456656334;30423.391532169233;3496.30073985204;3521.6654417830264;3590.2281009582803;3609.747317687763;3632.945505817415;256979;258240;258443;258660;260219.69890150617;51621;52400.475995240326;52432;52757;52841.735791320796;62721.37278627246;63157;63650.36349636537;63672.36327636665;63780.36219637744;15398.230088495531;15690.607734806721;15713.607159821097;15720.606984825243;15723.68552628941;9264.39781414206;9459.716208513755;11242.94378528102;12083.093767967437;12158.452869620889;18789.436316910516;19000.23999040023;19742.60514789696;19895;19939.30515906135;7144.285571442918;7345.449091318173;7373;7463.328300452985;7532.359749421361;888.9244414224734;903.4759839293195;1070.577122036791;1077.8167711489066;1134.1777211521746;28120.29699257535;28642;28883.56674649882;28926.27684307867;30272.84863575668;1019.7807471393686;1025.4565080507343;1034.736142283728;1064.6114168328504;1080.8486811846349;14235.64410889736;14268.85731142696;14346.784798228035;14544;14685.265736713336;341994;348070;348129;348415;348656;51758.482415175364;52009.479905201224;52045.73977130166;52066;52137.2179417309;1347.1512946843427;1364.501956785766;1371.067673981702;1377.9596404714378;1386.057480912989;27010.72989270161;28059.43881122407;28144.43711125807;28448.57327140053;29413.264668382606;43337.78331108324;43579.782101089295;43627.127457450035;43723.12553748971;43763;215657;216001;216633;216994;217069;28866.422671546872;30923;31512.36975260436;31900.361992760478;32004;37607.43588846115;37997.24005519819;38198.045048874;38243.617563824;39098;32108.839455803507;33167.33665326728;34288.828555857064;34441;35088;34912.47631285482;34916.30167396689;35187;35398.115047124025;35466.29067418689;33597.83201083979;34237.657623423445;34349.48475772915;34389.484157737155;34451;29961.850190748908;31211.375772484877;31856.362872741953;31905;31961.520577190895;23893.163739269043;23970;23992.520149597258;24035.75964240335;24258.63612045856 09:13:08 INFO - PROCESS | 524 | |2;jquery.html;338.0871646554304;355.26105700143705;355.98932032039033;356.0582259922505;356.78057994333477;12662.810057849128;16132.838671613295;16969.151542422893;17729.96105447874;17755.37856175034;15671.764923526156;15779.28993195306;16507.33970641173;16627.916860415713;16735.497935061936;3968.8412463501427;4141.79291035447;4145.647619952308;5146.562542183919;5353.411124776271;4067.4102255172984;4514.4582650081875;5917.55618328627;5921.585489015771;5923.318818335903;5098.464661210575;5324.92012619811;5868;5872.61827981182;5881.67650779207;5176.767045482962;5222.268882356435;5225.634205605628;5225.895482090375;5230.163173892178;4988.276699878534;5003.3495645565845;5014.398272207322;5016.44819069902;5022.070916880389;14214.431422743079;19428.12573434199;20161.8991905041;20170.39488815323;20415.081321340425;2069.3998740365278;2094.8743075415373;2104.5475222827167;2225.1321984426086;2310.4685922237813;9514.33399662024;9560.856587151198;9656.662016829378;9724.513774311326;12166.756664866742;1770.7343898415213;1780.1366337326385;1814.3468351393487;1814.5826459914294;1859.711744679577;54824;55028;55565;55983;56838;8972.730818075468;9268.25853931684;9513.429194248367;10002.099601075772;10146.746331341776;12658.177218480954;12697.301648409426;12742.745145097046;12752.80870786939;12777.744445111046;7643.808904777425;7669.271419215165;7763.107242667165;7825.060992680915;7838.451308408471;7722.806929826799;7787.29914307715;7790.220977902164;7814.101378341564;7847.058352997677;4432.15789000089;4448.755318457451;4461.5092339842595;4474.574915383034;4498.347739577808;1807.5842556212144;1829.2500074969198;1829.3962992212537;1835.4493651904643;1835.577817102074;420.78539944627846;429.3559660509236;468.0475232901098;967.6516454076527;1055.2824079625927;10345.74135646615;10981.505832237568;10994.670159895217;11086.833697494383;11266.380349080879;418.1928877266904;422.7019950934584;447.5502120369008;463.2703492000113;465.1371705486342;5980.431858973478;6082.604630699079;6158.507319414436;6209.316975132731;6219.502439804804;299350;300459;301221;301308;301392;71546.28453715396;72175.27824721791;72488;72819;75315;1118.6588090632272;1148.6439203846835;1158.5829101523445;1165.8717541070305;1169.1114752787942;12589.559365422167;14320.713585728436;14363;14597.854021460074;14949.551513454613;30536.236594085327;30544.236394090327;30664.84667576648;31483.685163148075;32198.35603287968;34985.65014349824;35281.647183527835;35381.46927796137;35513.82243088768;35882.64117358898;6339.746410143543;6675.699593518206;7088.787336379917;7197.388222000979;7342.3758980487255;7957.482763620346;11275.267107637977;11404.201705880509;11497.1377146716;11870;9623.518824058909;9754.170895473964;9948.45283509414;10011.199104071802;10058.949705251427;7728.690852365842;10102.797944041225;10179.898201018192;10284.794304114026;10535.42055186972;3168.588083549124;3171.555982162453;10141.949290253502;10142.869997300355;10566.471676415995;6151.477124444473;7290.088738907637;7313.597752123685;7735.342495887912;7766.611669416619;9800.411975281506;9986.151177150025;10176.847347289648;10325.32885362449;10366.652335196377 09:13:08 INFO - PROCESS | 524 | |3;mootools.html;1303.2441184113216;1451;1457.7886206500057;1602.8557429831312;1752.8860624059434;6759.324067593238;7440.144383395911;7594.202608726087;7594.24057594241;7598.544087354749;7325.340719335259;7489.063867016623;7531.09626844778;7540.095188577365;7550.282723141293;1991.0442987366073;2030.5126769575343;2033.613613413454;2312.826538009652;2340.8946597403155;2085.103405535619;2321.1991862807304;2350.882455877208;2355.5995480768224;2357.799587035104;2261.694671219389;2267.2178098556055;2298;2304.2626359564947;2348.56551537966;2293.3693234360517;2317.0731707317123;2318.7797159269926;2323.1288266899915;2325.38377330006;2324.6164382876805;2330.2310237621546;2330.2892617751577;2331.75516570761;2337.590921588715;7617.961910190414;7641.23587641237;7643.770686879402;7652.617369131521;7663.080430348338;4728.71627702339;4802.423709154924;4839.516048395168;4841.830535931225;4842.055799119174;2947.336849208932;2950.8967186148598;3037.1951432870305;3042.5284080967485;3048.0551029181024;976.5556671714353;1010.1464262698008;1024.71820249432;1030.2839526529065;1065.1265961911236;10479.633212837514;10513.684589462327;10517.474126293655;10544.736381590445;10552.683419497427;4376.431063961664;4400.317950717644;4469.687121901501;4474.172278128557;4493.303537951622;9157.633694652273;9160.496172710431;9165.129312715282;9183;9190.356675032817;4917.409910810726;4927.5811556017425;4943.036107958986;4945.060438516743;4948.257761335756;4434.135343607965;4493.28107502798;4500.3249512573375;4503;4506;3426.3489936911906;3470.132466883279;3677.8896633100517;3794.3739283017994;3805.5729101586903;1105.303658695017;1201.7296108375544;1218.6709588411256;1223.2171410297417;1237.1216436330126;1283.6020833541631;1294.779887419141;1298.5455090718362;1318.1168617026615;1341.684704094537;6998.230194678581;7027;7072.858542829114;7090.893636595455;7133.964330178316;1091.7052395853075;1106.6679996001167;1119.8712148103073;1120.3501968858043;1120.506976930148;5710.2862142232225;5743.62666426681;5756.856078598069;5761.308642962871;5764.13537969308;9213.12475314844;9263.397879137834;9267.53662316895;9283.535823208813;9390.107939745712;9211.76970575741;9338.626454941726;9342.813143737223;9350.298727595458;9351.205147562534;7214.49498535108;7215.855682886313;7265.600391978492;7376.557406555624;7395.741149059864;7078.398336141486;7099.432045436456;7102.4673149512955;7104.751333703295;7110.964445177741;8226.42415030966;8348.37387195975;8379.316371626226;8500;8519.574021299035;8607.225349718556;8687.174718401742;8795.824083518166;8795.956020220114;8807.427517211361;6580.8354791130605;6817.693203805741;6822.454203663794;6826.41975432074;6836.726530938906;6433.420992110732;6583.80248592543;6793.320667933167;7305.963470182615;7316.670749816165;6678.465722742266;6697.564658297195;6770.492213084137;6793.558418702769;6869.381755642016;6629.867402651824;6667.8666426670225;6678.365555272241;6777.491688123312;6795.3204679531655;6834.692438840363;6863.828404289933;6884.724611015704;6888.758893438706;6889.311068893071;6207.34822843613;6317.778877739257;6356.904646430215;6394.4564712;6397.776077837253;6434.195725534309;6571.934280657132;6574.539782215199;6588.571742836701;6592.538522303585 09:13:08 INFO - PROCESS | 524 | |4;prototype.html;333.54138060167264;335.3025706530417;340.6933759616347;345.37831902575357;346.7815276375881;5798.420157984205;5800.100984347422;5806.390329015446;5814.738336774844;5817.505512031477;5537.723113844302;5572;5661.179129026289;5725.656460612356;5814.883702325961;4451.799669014902;4475.977620111911;4481.327800829886;4486.394336764536;4490.191765482212;4288.69979101463;4488.124815660947;4528.7056341337875;4535.387722657449;4545.52272011439;4298.935515967263;4307.978460107695;4373.868783936471;4398.472183338004;4404.163208990298;4378.737275763448;4384.780760961971;4394.4287242658565;4405.140997505488;4409.162259170764;3876.5154355705536;3877.2245550889934;3887.5140607424073;3897.4543563901075;3929.5088113985753;5503.367112782002;5548.55611551075;5557.305336832896;5561.63849349791;5563.860903477405;5225.19009553516;5274.604404669627;5278.023565640369;5283.365996080495;5287;6172.59878107926;6176.104464852571;6184.165137706397;6190.576167481459;6200.441960223601;4415.050764085705;4431.446069241345;4434.401355816955;4440.200763862504;4453.977730111361;6347;6361.045843123568;6431.485481161542;6452.548321617535;6460.160179176677;4513.277875539898;4518.344839998182;4519;4521.660875434355;4523.411956445641;4580.061087477059;4580.427446569179;4584.7936842842155;4587.059652771174;4587.72473651582;5224.52979231871;5232.03207406631;5234;5234.869128271824;5241.292425522582;6002;6208.4722798561725;6211.819754246679;6225.252969643581;6238.344973777779;1610.7664388663577;1631.3719218101116;1632.5347276026275;1634.632207753246;1634.991825040891;1089.1123734156638;1092.8415379769888;1111.7609713911547;1116.430620383594;1137.766757814646;5751;5768.625039372428;5800.88398232033;5813.59304848665;5826.0678291474005;6328.968355158195;6349.55553111287;6351.079093531412;6357.682115894187;6363.077353783768;5614.522765564891;5713.285839270091;5714.371419143891;5717.999350113713;5736.942630573724;3409.232922592397;3448.3103379324234;3450.240946991708;3450.7929524228625;3456.9654303457146;6568.014797780275;6569.770058047945;6578.76974305897;6589.374009469188;6589.7364105435245;6368.203974503187;6554.606723596599;6558.803235902835;6566.8358291043105;6593.7362505500205;6494.155759751202;6515.706793194412;6516.771912983023;6520.054592084121;6531.542792004514;6361.232863704304;6428.646424446513;6430.935690643034;6431.549791514736;6437.163168788027;6189.84525386869;6366.331535188739;6373.267074286331;6379.393957574023;6394.552381333262;6592.406683398325;6598.736050557924;6600.768973085919;6609.669516524251;6612.371824676648;4344.826206951813;4350.673699472489;4370.934435983399;4389.253826849507;4390.670699697472;6234.812955611339;6433.324500927522;6436.581622194542;6436.935630643634;6439;6221.035739460391;6232.407921247474;6249.593776404519;6264.154339164154;6269.373062693694;6251.46862516673;6263.74945002213;6264.2796078451565;6265.655388953469;6266.248050234001;5929.288485381781;6142.385761423822;6151.6001459904965;6157.0456579230295;6168.290646575521;6284.24589049317;6290.150829637941;6290.716917738804;6292.528060395397;6298.590591611531;6074.757009719562;6129.111278864629;6151.446369826737;6152.692365381624;6162.137300777984 09:13:08 INFO - PROCESS | 524 | |5;yui.html;767.9654415551303;793.0562630469741;819.3199644295236;853.5476197615262;856.7943693513556;11771.470283837227;11962.521499140035;11984.820227696591;12003.399830008497;12005.579804706837;12503.624891253254;12686.682832929182;12702.23786572804;12727.554535591256;12729.554465593706;810.4448452809814;826.4008593769529;826.7313123234973;826.7478419082178;826.9421140520166;814.071957967917;817.1134319263606;817.4686453805015;817.5952903312868;817.709713051867;845.18439705684;847.076686411811;848.0163010907348;848.0586548930713;848.0628905059913;838.995805020974;844.4004756622805;844.9028361738417;845.0830848529353;845.9365547583925;628.2021832273033;629.7984644913629;629.9244090709144;631.0471188505344;632.2476253258653;13335.799963000563;13364.13133146352;13380;13470.932645336808;13504.257265850374;12782.360881955958;12868.485260589565;12878.098533102686;12939.5471158509;13062.54281100157;10445.529951152217;10458.320209186379;10623.893761062367;10760.11697952863;11088.112950963903;4088.1414902870433;4197.517285512175;4223.282042052859;4224.408582798411;4244.511881133678;37259;41526.792366037975;41556.376654350206;41836;44370.334444983026;9839.901600983898;9904.950475247577;9908.950455247677;10037;10206.438645874548;16227.594310142342;16344.918275408785;16400;16829.074400907823;16834.326626934784;7508.887366689504;7516.323530882138;7586.203448637924;7638.770836874903;7746.49647772893;4391.956080439155;4402.141582391403;4442.711223770445;4452.510223875371;4486.484054333728;3107.083410393939;3116.703913128249;3127.405792899342;3128.7340576050833;3133.2950086230417;547.9726013699379;557.8744782423922;570.785955266775;574.4657468554201;589.9882002359928;503.62983207342575;555.5500044963593;581.9621724587888;665.8801415745115;683.0744341417308;8841.778955526162;8857.29141668665;8961.327900407496;8982.461052336881;9074.727758167266;649.9834288851855;669.263809809206;672.1463741048841;675.2133764164792;704.1936982155403;4003.939940900889;4007.8597249096724;4148.191102734938;4168.937465938014;4183.184279065553;58171.545711357554;60066.09900851491;60133.69933150306;60218;60237;50663.7466812671;51341;51744;51894.48105518972;52388.73805630948;40923.59076409257;42018.15963680709;45013.77493112513;45230;48796.02407951821;9138.406003609743;9264.675736349196;9303.581338839633;9317.580708867981;9358.719238422858;34750.13124671904;35382;35515.46726799152;36035.27929441344;36185;39272.214555709295;39322.6067739319;41932.58067419287;42231.366529501465;50159.74920125376;10393.84409233847;10493.422861742678;11454.255473394203;11478.598249061242;11869.050475961729;12374.257544547356;12576.427946506687;12598.937005314914;12885.162464439782;13323.933380333036;11496.195266331611;11590.710232243924;11777;12041.759164816829;12444.191127576678;11617.244879082833;11637.359945202756;12012.099092568267;12033.518659253532;12447.875521244672;10343.844842327522;10598.20513461478;10612.734681633021;11001.779964400506;11123.666290011313;8774.210321071134;8971.690154204034;9054.32092593045;9134.908650913672;9161.450312981242;9218.52503599421;9365.953170234105;10044.497775111362;10046.69859904204;10171.084602385821 09:13:08 INFO - PROCESS | 524 | __end_tp_report 09:13:08 INFO - PROCESS | 524 | __start_cc_report 09:13:08 INFO - PROCESS | 524 | _x_x_mozilla_cycle_collect,886 09:13:08 INFO - PROCESS | 524 | __end_cc_report 09:13:08 INFO - PROCESS | 524 | __startTimestamp1452532388361__endTimestamp 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | ------- Summary: start ------- 09:13:08 INFO - PROCESS | 524 | Number of tests: 6 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | [#0] dojo.html Cycles:165 Average:5025.46 Median:5236.66 stddev:514.73 (9.8%) stddev-sans-first:493.88 09:13:08 INFO - PROCESS | 524 | Values: 3109.6 3157.8 3199.9 3203.7 3230.7 4866.8 5023.1 5047.6 5085.5 5138.8 5008.3 5015.5 5055.9 5067.1 5123.1 4435.6 4571.1 4629.6 4677.8 4840.9 4521.6 4710.0 4737.3 4767.4 4797.2 4592.2 4610.9 4664.9 4698.2 4723.2 4587.7 4594.2 4594.7 4595.9 4645.7 4558.9 4573.5 4578.2 4602.7 4608.5 4832.7 4840.9 4909.9 4917.0 4943.2 5344.0 5351.2 5357.0 5364.5 5365.1 5388.7 5406.8 5411.5 5412.5 5472.5 4924.8 5012.5 5081.8 5186.6 5209.7 5582.2 5589.4 5596.9 5603.0 5646.3 5348.1 5374.5 5374.8 5376.7 5380.2 5329.4 5356.3 5447.0 5474.0 5483.1 5420.2 5450.9 5453.0 5455.4 5460.8 5444.8 5447.1 5449.7 5454.2 5458.1 4192.6 4207.4 4272.3 4273.7 4274.6 3837.0 3841.0 3848.2 3864.8 3878.4 5054.6 5064.5 5065.4 5071.5 5089.8 5259.7 5323.3 5335.3 5440.5 5457.0 4905.3 4988.6 5016.4 5044.2 5056.5 4610.6 4616.8 4625.9 4628.5 4709.7 5290.7 5353.6 5483.9 5488.5 5534.4 5282.9 5341.4 5353.2 5356.8 5378.7 5357.3 5359.3 5359.7 5361.7 5380.5 5132.7 5188.0 5271.5 5297.7 5390.9 5282.0 5313.6 5440.5 5441.2 5488.0 5310.3 5320.0 5336.9 5340.8 5342.3 5204.8 5259.3 5310.2 5311.8 5354.0 5095.6 5236.7 5294.7 5300.7 5339.2 5304.4 5310.3 5340.5 5343.1 5399.6 5063.1 5146.8 5231.9 5238.2 5242.8 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | [#1] ext.html Cycles:180 Average:43830.76 Median:348272.00 stddev:73185.26 (21.0%) stddev-sans-first:73318.42 09:13:08 INFO - PROCESS | 524 | Values: 550.4 581.9 597.7 601.2 605.5 27725.4 28335.1 32530.8 32853.3 32899.5 38259.0 38747.8 38868.2 38875.0 38954.0 8391.1 8514.7 8575.9 8578.8 8591.4 8352.8 8474.2 8498.2 8505.2 8514.7 8603.7 8628.2 8694.6 8700.8 8702.6 8617.9 8637.6 8690.2 8701.0 8705.9 8494.3 8634.5 8650.2 8658.4 8661.4 38012.2 38563.8 38594.0 38674.4 38675.6 3360.2 3399.8 3410.7 3508.5 3518.5 28975.4 29348.0 29372.9 29618.1 30423.4 3496.3 3521.7 3590.2 3609.7 3632.9 256979.0 258240.0 258443.0 258660.0 260219.7 51621.0 52400.5 52432.0 52757.0 52841.7 62721.4 63157.0 63650.4 63672.4 63780.4 15398.2 15690.6 15713.6 15720.6 15723.7 9264.4 9459.7 11242.9 12083.1 12158.5 18789.4 19000.2 19742.6 19895.0 19939.3 7144.3 7345.4 7373.0 7463.3 7532.4 888.9 903.5 1070.6 1077.8 1134.2 28120.3 28642.0 28883.6 28926.3 30272.8 1019.8 1025.5 1034.7 1064.6 1080.8 14235.6 14268.9 14346.8 14544.0 14685.3 341994.0 348070.0 348129.0 348415.0 348656.0 51758.5 52009.5 52045.7 52066.0 52137.2 1347.2 1364.5 1371.1 1378.0 1386.1 27010.7 28059.4 28144.4 28448.6 29413.3 43337.8 43579.8 43627.1 43723.1 43763.0 215657.0 216001.0 216633.0 216994.0 217069.0 28866.4 30923.0 31512.4 31900.4 32004.0 37607.4 37997.2 38198.0 38243.6 39098.0 32108.8 33167.3 34288.8 34441.0 35088.0 34912.5 34916.3 35187.0 35398.1 35466.3 33597.8 34237.7 34349.5 34389.5 34451.0 29961.9 31211.4 31856.4 31905.0 31961.5 23893.2 23970.0 23992.5 24035.8 24258.6 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | [#2] jquery.html Cycles:180 Average:20196.54 Median:18119.71 stddev:49825.25 (275.0%) stddev-sans-first:49942.72 09:13:08 INFO - PROCESS | 524 | Values: 338.1 355.3 356.0 356.1 356.8 12662.8 16132.8 16969.2 17730.0 17755.4 15671.8 15779.3 16507.3 16627.9 16735.5 3968.8 4141.8 4145.6 5146.6 5353.4 4067.4 4514.5 5917.6 5921.6 5923.3 5098.5 5324.9 5868.0 5872.6 5881.7 5176.8 5222.3 5225.6 5225.9 5230.2 4988.3 5003.3 5014.4 5016.4 5022.1 14214.4 19428.1 20161.9 20170.4 20415.1 2069.4 2094.9 2104.5 2225.1 2310.5 9514.3 9560.9 9656.7 9724.5 12166.8 1770.7 1780.1 1814.3 1814.6 1859.7 54824.0 55028.0 55565.0 55983.0 56838.0 8972.7 9268.3 9513.4 10002.1 10146.7 12658.2 12697.3 12742.7 12752.8 12777.7 7643.8 7669.3 7763.1 7825.1 7838.5 7722.8 7787.3 7790.2 7814.1 7847.1 4432.2 4448.8 4461.5 4474.6 4498.3 1807.6 1829.3 1829.4 1835.4 1835.6 420.8 429.4 468.0 967.7 1055.3 10345.7 10981.5 10994.7 11086.8 11266.4 418.2 422.7 447.6 463.3 465.1 5980.4 6082.6 6158.5 6209.3 6219.5 299350.0 300459.0 301221.0 301308.0 301392.0 71546.3 72175.3 72488.0 72819.0 75315.0 1118.7 1148.6 1158.6 1165.9 1169.1 12589.6 14320.7 14363.0 14597.9 14949.6 30536.2 30544.2 30664.8 31483.7 32198.4 34985.7 35281.6 35381.5 35513.8 35882.6 6339.7 6675.7 7088.8 7197.4 7342.4 7957.5 11275.3 11404.2 11497.1 11870.0 9623.5 9754.2 9948.5 10011.2 10058.9 7728.7 10102.8 10179.9 10284.8 10535.4 3168.6 3171.6 10141.9 10142.9 10566.5 6151.5 7290.1 7313.6 7735.3 7766.6 9800.4 9986.2 10176.8 10325.3 10366.7 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | [#3] mootools.html Cycles:180 Average:5413.98 Median:6337.34 stddev:2762.81 (43.6%) stddev-sans-first:2753.28 09:13:08 INFO - PROCESS | 524 | Values: 1303.2 1451.0 1457.8 1602.9 1752.9 6759.3 7440.1 7594.2 7594.2 7598.5 7325.3 7489.1 7531.1 7540.1 7550.3 1991.0 2030.5 2033.6 2312.8 2340.9 2085.1 2321.2 2350.9 2355.6 2357.8 2261.7 2267.2 2298.0 2304.3 2348.6 2293.4 2317.1 2318.8 2323.1 2325.4 2324.6 2330.2 2330.3 2331.8 2337.6 7618.0 7641.2 7643.8 7652.6 7663.1 4728.7 4802.4 4839.5 4841.8 4842.1 2947.3 2950.9 3037.2 3042.5 3048.1 976.6 1010.1 1024.7 1030.3 1065.1 10479.6 10513.7 10517.5 10544.7 10552.7 4376.4 4400.3 4469.7 4474.2 4493.3 9157.6 9160.5 9165.1 9183.0 9190.4 4917.4 4927.6 4943.0 4945.1 4948.3 4434.1 4493.3 4500.3 4503.0 4506.0 3426.3 3470.1 3677.9 3794.4 3805.6 1105.3 1201.7 1218.7 1223.2 1237.1 1283.6 1294.8 1298.5 1318.1 1341.7 6998.2 7027.0 7072.9 7090.9 7134.0 1091.7 1106.7 1119.9 1120.4 1120.5 5710.3 5743.6 5756.9 5761.3 5764.1 9213.1 9263.4 9267.5 9283.5 9390.1 9211.8 9338.6 9342.8 9350.3 9351.2 7214.5 7215.9 7265.6 7376.6 7395.7 7078.4 7099.4 7102.5 7104.8 7111.0 8226.4 8348.4 8379.3 8500.0 8519.6 8607.2 8687.2 8795.8 8796.0 8807.4 6580.8 6817.7 6822.5 6826.4 6836.7 6433.4 6583.8 6793.3 7306.0 7316.7 6678.5 6697.6 6770.5 6793.6 6869.4 6629.9 6667.9 6678.4 6777.5 6795.3 6834.7 6863.8 6884.7 6888.8 6889.3 6207.3 6317.8 6356.9 6394.5 6397.8 6434.2 6571.9 6574.5 6588.6 6592.5 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | [#4] prototype.html Cycles:180 Average:5182.98 Median:5783.52 stddev:1542.62 (26.7%) stddev-sans-first:1503.39 09:13:08 INFO - PROCESS | 524 | Values: 333.5 335.3 340.7 345.4 346.8 5798.4 5800.1 5806.4 5814.7 5817.5 5537.7 5572.0 5661.2 5725.7 5814.9 4451.8 4476.0 4481.3 4486.4 4490.2 4288.7 4488.1 4528.7 4535.4 4545.5 4298.9 4308.0 4373.9 4398.5 4404.2 4378.7 4384.8 4394.4 4405.1 4409.2 3876.5 3877.2 3887.5 3897.5 3929.5 5503.4 5548.6 5557.3 5561.6 5563.9 5225.2 5274.6 5278.0 5283.4 5287.0 6172.6 6176.1 6184.2 6190.6 6200.4 4415.1 4431.4 4434.4 4440.2 4454.0 6347.0 6361.0 6431.5 6452.5 6460.2 4513.3 4518.3 4519.0 4521.7 4523.4 4580.1 4580.4 4584.8 4587.1 4587.7 5224.5 5232.0 5234.0 5234.9 5241.3 6002.0 6208.5 6211.8 6225.3 6238.3 1610.8 1631.4 1632.5 1634.6 1635.0 1089.1 1092.8 1111.8 1116.4 1137.8 5751.0 5768.6 5800.9 5813.6 5826.1 6329.0 6349.6 6351.1 6357.7 6363.1 5614.5 5713.3 5714.4 5718.0 5736.9 3409.2 3448.3 3450.2 3450.8 3457.0 6568.0 6569.8 6578.8 6589.4 6589.7 6368.2 6554.6 6558.8 6566.8 6593.7 6494.2 6515.7 6516.8 6520.1 6531.5 6361.2 6428.6 6430.9 6431.5 6437.2 6189.8 6366.3 6373.3 6379.4 6394.6 6592.4 6598.7 6600.8 6609.7 6612.4 4344.8 4350.7 4370.9 4389.3 4390.7 6234.8 6433.3 6436.6 6436.9 6439.0 6221.0 6232.4 6249.6 6264.2 6269.4 6251.5 6263.7 6264.3 6265.7 6266.2 5929.3 6142.4 6151.6 6157.0 6168.3 6284.2 6290.2 6290.7 6292.5 6298.6 6074.8 6129.1 6151.4 6152.7 6162.1 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - PROCESS | 524 | [#5] yui.html Cycles:180 Average:13579.97 Median:4397.05 stddev:15566.60 (354.0%) stddev-sans-first:15580.53 09:13:08 INFO - PROCESS | 524 | Values: 768.0 793.1 819.3 853.5 856.8 11771.5 11962.5 11984.8 12003.4 12005.6 12503.6 12686.7 12702.2 12727.6 12729.6 810.4 826.4 826.7 826.7 826.9 814.1 817.1 817.5 817.6 817.7 845.2 847.1 848.0 848.1 848.1 839.0 844.4 844.9 845.1 845.9 628.2 629.8 629.9 631.0 632.2 13335.8 13364.1 13380.0 13470.9 13504.3 12782.4 12868.5 12878.1 12939.5 13062.5 10445.5 10458.3 10623.9 10760.1 11088.1 4088.1 4197.5 4223.3 4224.4 4244.5 37259.0 41526.8 41556.4 41836.0 44370.3 9839.9 9905.0 9909.0 10037.0 10206.4 16227.6 16344.9 16400.0 16829.1 16834.3 7508.9 7516.3 7586.2 7638.8 7746.5 4392.0 4402.1 4442.7 4452.5 4486.5 3107.1 3116.7 3127.4 3128.7 3133.3 548.0 557.9 570.8 574.5 590.0 503.6 555.6 582.0 665.9 683.1 8841.8 8857.3 8961.3 8982.5 9074.7 650.0 669.3 672.1 675.2 704.2 4003.9 4007.9 4148.2 4168.9 4183.2 58171.5 60066.1 60133.7 60218.0 60237.0 50663.7 51341.0 51744.0 51894.5 52388.7 40923.6 42018.2 45013.8 45230.0 48796.0 9138.4 9264.7 9303.6 9317.6 9358.7 34750.1 35382.0 35515.5 36035.3 36185.0 39272.2 39322.6 41932.6 42231.4 50159.7 10393.8 10493.4 11454.3 11478.6 11869.1 12374.3 12576.4 12598.9 12885.2 13323.9 11496.2 11590.7 11777.0 12041.8 12444.2 11617.2 11637.4 12012.1 12033.5 12447.9 10343.8 10598.2 10612.7 11001.8 11123.7 8774.2 8971.7 9054.3 9134.9 9161.5 9218.5 9366.0 10044.5 10046.7 10171.1 09:13:08 INFO - PROCESS | 524 | -------- Summary: end -------- 09:13:08 INFO - PROCESS | 524 | 09:13:08 INFO - TEST-INFO | 524: exit 0 09:13:09 INFO - TEST-OK | dromaeo_css | took 1111753ms 09:13:09 INFO - TEST-START | kraken 09:13:09 INFO - operating with platform_type : linux_ 09:13:09 INFO - Initialising browser for kraken test... 09:13:09 INFO - TEST-INFO | started process 716 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxzkqOT/profile http://localhost:37726/getInfo.html) 09:13:12 INFO - PROCESS | 716 | __metrics Screen width/height:1600/1200 09:13:12 INFO - PROCESS | 716 | colorDepth:24 09:13:12 INFO - PROCESS | 716 | Browser inner width/height: 1024/697 09:13:12 INFO - PROCESS | 716 | __metrics 09:13:12 INFO - PROCESS | 716 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:13:12 INFO - PROCESS | 716 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:13 INFO - TEST-INFO | 716: exit 0 09:13:13 INFO - Browser initialized. 09:13:13 INFO - Running cycle 1/1 for kraken test... 09:13:13 INFO - TEST-INFO | started process 800 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxzkqOT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:25 INFO - PROCESS | 800 | RSS: Main: 149250048 09:13:25 INFO - PROCESS | 800 | 09:13:27 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37726/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:28 INFO - PROCESS | 800 | RSS: Main: 186892288 09:13:28 INFO - PROCESS | 800 | 09:13:31 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37726/tests/kraken/driver.html?testName=audio-dft) 09:13:31 INFO - PROCESS | 800 | RSS: Main: 175394816 09:13:31 INFO - PROCESS | 800 | 09:13:34 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37726/tests/kraken/driver.html?testName=audio-fft) 09:13:35 INFO - PROCESS | 800 | RSS: Main: 161005568 09:13:35 INFO - PROCESS | 800 | 09:13:37 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37726/tests/kraken/driver.html?testName=audio-oscillator) 09:13:37 INFO - PROCESS | 800 | RSS: Main: 161083392 09:13:37 INFO - PROCESS | 800 | 09:13:39 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37726/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:40 INFO - PROCESS | 800 | RSS: Main: 163950592 09:13:40 INFO - PROCESS | 800 | 09:13:43 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37726/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:43 INFO - PROCESS | 800 | RSS: Main: 164048896 09:13:43 INFO - PROCESS | 800 | 09:13:47 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37726/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:47 INFO - PROCESS | 800 | RSS: Main: 165785600 09:13:47 INFO - PROCESS | 800 | 09:13:50 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37726/tests/kraken/driver.html?testName=json-parse-financial) 09:13:51 INFO - PROCESS | 800 | RSS: Main: 164978688 09:13:51 INFO - PROCESS | 800 | 09:13:52 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37726/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:53 INFO - PROCESS | 800 | RSS: Main: 176848896 09:13:53 INFO - PROCESS | 800 | 09:13:55 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37726/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:55 INFO - PROCESS | 800 | RSS: Main: 174968832 09:13:55 INFO - PROCESS | 800 | 09:13:57 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37726/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:58 INFO - PROCESS | 800 | RSS: Main: 184963072 09:13:58 INFO - PROCESS | 800 | 09:14:00 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:01 INFO - PROCESS | 800 | RSS: Main: 189628416 09:14:01 INFO - PROCESS | 800 | 09:14:04 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:04 INFO - PROCESS | 800 | RSS: Main: 188768256 09:14:04 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | Cycle 1(1): loaded http://localhost:37726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37726/tests/kraken/driver.html?testName=ai-astar) 09:14:06 INFO - PROCESS | 800 | RSS: Main: 245723136 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | __start_tp_report 09:14:06 INFO - PROCESS | 800 | _x_x_mozilla_page_load 09:14:06 INFO - PROCESS | 800 | _x_x_mozilla_page_load_details 09:14:06 INFO - PROCESS | 800 | |i|pagename|runs| 09:14:06 INFO - PROCESS | 800 | |0;ai-astar;111;114;108;111;111;114;102;111;112;113 09:14:06 INFO - PROCESS | 800 | |1;audio-beat-detection;157;126;149;163;128;152;159;123;164;131 09:14:06 INFO - PROCESS | 800 | |2;audio-dft;162;163;159;163;162;159;159;163;161;161 09:14:06 INFO - PROCESS | 800 | |3;audio-fft;72;74;86;89;75;71;75;115;95;73 09:14:06 INFO - PROCESS | 800 | |4;audio-oscillator;95;97;140;95;96;96;139;95;97;137 09:14:06 INFO - PROCESS | 800 | |5;imaging-gaussian-blur;109;110;109;109;110;109;111;110;110;110 09:14:06 INFO - PROCESS | 800 | |6;imaging-darkroom;146;145;146;146;145;144;146;145;145;145 09:14:06 INFO - PROCESS | 800 | |7;imaging-desaturate;96;96;96;95;96;96;96;97;96;96 09:14:06 INFO - PROCESS | 800 | |8;json-parse-financial;57;55;56;55;56;54;55;64;54;56 09:14:06 INFO - PROCESS | 800 | |9;json-stringify-tinderbox;67;68;68;67;71;68;68;67;68;68 09:14:06 INFO - PROCESS | 800 | |10;stanford-crypto-aes;84;86;84;85;86;87;86;85;86;85 09:14:06 INFO - PROCESS | 800 | |11;stanford-crypto-ccm;117;117;119;130;116;133;117;126;118;116 09:14:06 INFO - PROCESS | 800 | |12;stanford-crypto-pbkdf2;144;143;168;151;142;158;158;163;149;141 09:14:06 INFO - PROCESS | 800 | |13;stanford-crypto-sha256-iterative;71;68;68;72;70;76;67;69;67;67 09:14:06 INFO - PROCESS | 800 | __end_tp_report 09:14:06 INFO - PROCESS | 800 | __start_cc_report 09:14:06 INFO - PROCESS | 800 | _x_x_mozilla_cycle_collect,944 09:14:06 INFO - PROCESS | 800 | __end_cc_report 09:14:06 INFO - PROCESS | 800 | __startTimestamp1452532446529__endTimestamp 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | ------- Summary: start ------- 09:14:06 INFO - PROCESS | 800 | Number of tests: 14 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:3.53 (3.2%) stddev-sans-first:3.74 09:14:06 INFO - PROCESS | 800 | Values: 111.0 114.0 108.0 111.0 111.0 114.0 102.0 111.0 112.0 113.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:154.50 stddev:16.40 (10.6%) stddev-sans-first:16.83 09:14:06 INFO - PROCESS | 800 | Values: 157.0 126.0 149.0 163.0 128.0 152.0 159.0 123.0 164.0 131.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.69 (1.0%) stddev-sans-first:1.76 09:14:06 INFO - PROCESS | 800 | Values: 162.0 163.0 159.0 163.0 162.0 159.0 159.0 163.0 161.0 161.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:14.08 (18.8%) stddev-sans-first:14.41 09:14:06 INFO - PROCESS | 800 | Values: 72.0 74.0 86.0 89.0 75.0 71.0 75.0 115.0 95.0 73.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.50 stddev:20.70 (21.7%) stddev-sans-first:21.36 09:14:06 INFO - PROCESS | 800 | Values: 95.0 97.0 140.0 95.0 96.0 96.0 139.0 95.0 97.0 137.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 09:14:06 INFO - PROCESS | 800 | Values: 109.0 110.0 109.0 109.0 110.0 109.0 111.0 110.0 110.0 110.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 09:14:06 INFO - PROCESS | 800 | Values: 146.0 145.0 146.0 146.0 145.0 144.0 146.0 145.0 145.0 145.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 09:14:06 INFO - PROCESS | 800 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 96.0 96.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.90 (5.2%) stddev-sans-first:3.06 09:14:06 INFO - PROCESS | 800 | Values: 57.0 55.0 56.0 55.0 56.0 54.0 55.0 64.0 54.0 56.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 09:14:06 INFO - PROCESS | 800 | Values: 67.0 68.0 68.0 67.0 71.0 68.0 68.0 67.0 68.0 68.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:0.88 09:14:06 INFO - PROCESS | 800 | Values: 84.0 86.0 84.0 85.0 86.0 87.0 86.0 85.0 86.0 85.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:118.50 stddev:6.33 (5.3%) stddev-sans-first:6.56 09:14:06 INFO - PROCESS | 800 | Values: 117.0 117.0 119.0 130.0 116.0 133.0 117.0 126.0 118.0 116.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:154.50 stddev:9.57 (6.2%) stddev-sans-first:9.74 09:14:06 INFO - PROCESS | 800 | Values: 144.0 143.0 168.0 151.0 142.0 158.0 158.0 163.0 149.0 141.0 09:14:06 INFO - PROCESS | 800 | 09:14:06 INFO - PROCESS | 800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:2.88 (4.1%) stddev-sans-first:3.00 09:14:06 INFO - PROCESS | 800 | Values: 71.0 68.0 68.0 72.0 70.0 76.0 67.0 69.0 67.0 67.0 09:14:06 INFO - PROCESS | 800 | -------- Summary: end -------- 09:14:06 INFO - PROCESS | 800 | 09:14:07 INFO - TEST-INFO | 800: exit 0 09:14:07 INFO - TEST-OK | kraken | took 58413ms 09:14:07 INFO - TEST-START | v8_7 09:14:07 INFO - operating with platform_type : linux_ 09:14:07 INFO - Initialising browser for v8_7 test... 09:14:07 INFO - TEST-INFO | started process 1064 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkhPF2l/profile http://localhost:37726/getInfo.html) 09:14:10 INFO - PROCESS | 1064 | __metrics Screen width/height:1600/1200 09:14:10 INFO - PROCESS | 1064 | colorDepth:24 09:14:10 INFO - PROCESS | 1064 | Browser inner width/height: 1024/697 09:14:10 INFO - PROCESS | 1064 | __metrics 09:14:11 INFO - PROCESS | 1064 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:14:11 INFO - PROCESS | 1064 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:12 INFO - TEST-INFO | 1064: exit 0 09:14:12 INFO - Browser initialized. 09:14:12 INFO - Running cycle 1/1 for v8_7 test... 09:14:12 INFO - TEST-INFO | started process 1210 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkhPF2l/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:23 INFO - PROCESS | 1210 | RSS: Main: 148602880 09:14:23 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | Cycle 1(1): loaded http://localhost:37726/tests/v8_7/run.html (next: http://localhost:37726/tests/v8_7/run.html) 09:14:46 INFO - PROCESS | 1210 | RSS: Main: 578142208 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | __start_tp_report 09:14:46 INFO - PROCESS | 1210 | _x_x_mozilla_page_load 09:14:46 INFO - PROCESS | 1210 | _x_x_mozilla_page_load_details 09:14:46 INFO - PROCESS | 1210 | |i|pagename|runs| 09:14:46 INFO - PROCESS | 1210 | |0;Richards;166.25103906899417 09:14:46 INFO - PROCESS | 1210 | |1;DeltaBlue;191.05846388995033 09:14:46 INFO - PROCESS | 1210 | |2;Encrypt;283.04557033682426 09:14:46 INFO - PROCESS | 1210 | |3;Decrypt;5251.308900523561 09:14:46 INFO - PROCESS | 1210 | |4;RayTrace;1106.1946902654868 09:14:46 INFO - PROCESS | 1210 | |5;Earley;784.9293563579278 09:14:46 INFO - PROCESS | 1210 | |6;Boyer;12219.512195121952 09:14:46 INFO - PROCESS | 1210 | |7;RegExp;42957.44680851064 09:14:46 INFO - PROCESS | 1210 | |8;Splay;606.060606060606 09:14:46 INFO - PROCESS | 1210 | |9;NavierStokes;4826.923076923077 09:14:46 INFO - PROCESS | 1210 | __end_tp_report 09:14:46 INFO - PROCESS | 1210 | __startTimestamp1452532486433__endTimestamp 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | ------- Summary: start ------- 09:14:46 INFO - PROCESS | 1210 | Number of tests: 10 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 166.3 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#1] DeltaBlue Cycles:1 Average:191.06 Median:191.06 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 191.1 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#2] Encrypt Cycles:1 Average:283.05 Median:283.05 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 283.0 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 5251.3 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 1106.2 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 784.9 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 12219.5 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#7] RegExp Cycles:1 Average:42957.45 Median:42957.45 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 42957.4 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#8] Splay Cycles:1 Average:606.06 Median:606.06 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 606.1 09:14:46 INFO - PROCESS | 1210 | 09:14:46 INFO - PROCESS | 1210 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:14:46 INFO - PROCESS | 1210 | Values: 4826.9 09:14:46 INFO - PROCESS | 1210 | -------- Summary: end -------- 09:14:46 INFO - PROCESS | 1210 | 09:14:47 INFO - TEST-INFO | 1210: exit 0 09:14:47 INFO - TEST-OK | v8_7 | took 39816ms 09:14:47 INFO - SUITE-END | took 1209s 09:14:47 INFO - Completed test suite (00:20:10) 09:14:47 INFO - Working with test: dromaeo_css 09:14:47 INFO - Generating results file: dromaeo_css 09:14:47 INFO - Working with test: kraken 09:14:47 INFO - Generating results file: kraken 09:14:47 INFO - javascript benchmark 09:14:47 INFO - Working with test: v8_7 09:14:47 INFO - Generating results file: v8_7 09:14:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 09:14:47 INFO - process_Request line: dromaeo_css 6668.34 graph.html#tests=[[72,1,35]] 09:14:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:47 INFO - process_Request line: kraken 1511.00 graph.html#tests=[[232,1,35]] 09:14:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:14:47 INFO - process_Request line: v8_7 19964.30 graph.html#tests=[[230,1,35]] 09:14:47 INFO - RETURN: dromaeo_css: 6668.34 09:14:47 INFO - RETURN: kraken: 1511.00 09:14:47 INFO - RETURN: v8_7: 19964.30 09:14:47 INFO - javascript benchmark 09:14:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3109.595752552168, 3157.794743341681, 3199.936001279973, 3203.711665950064, 3230.741540676746, 4866.756662166887, 5023.120953833083, 5047.621428392871, 5085.466026067261, 5138.845834624958, 5008.298838162651, 5015.4984501549825, 5055.924161137576, 5067.138586440305, 5123.052235336456, 4435.645148388137, 4571.131485017852, 4629.629629629639, 4677.789499472515, 4840.878978025542, 4521.638268938494, 4710.0, 4737.336772851803, 4767.380240568721, 4797.18447863864, 4592.150452166343, 4610.861674149764, 4664.930026049612, 4698.177818881699, 4723.244280915072, 4587.747673877935, 4594.2419500782335, 4594.65540084495, 4595.931061034087, 4645.674802763808, 4558.8632341029825, 4573.474050484204, 4578.244589642705, 4602.746848923308, 4608.516105808875, 4832.661713680044, 4840.854774356775, 4909.8772530686665, 4917.016596680678, 4943.209086546171, 5344.0, 5351.2240725095035, 5357.035733567956, 5364.490373414558, 5365.08793505105, 5388.703621300827, 5406.783728650849, 5411.485908838654, 5412.458754124556, 5472.452754724535, 4924.80300787968, 5012.523810238022, 5081.79672813087, 5186.611004174702, 5209.739513024334, 5582.190582365615, 5589.441055894459, 5596.888062238732, 5603.047481928082, 5646.2942132233475, 5348.1442969124755, 5374.48942350476, 5374.838754837361, 5376.7042812644895, 5380.166074258496, 5329.413764485904, 5356.303680521585, 5447.046766815792, 5474.0146773580345, 5483.095289277225, 5420.186971954238, 5450.8909821803345, 5453.0, 5455.399906010336, 5460.781568737286, 5444.8094316698725, 5447.101228297287, 5449.727513624303, 5454.181872719124, 5458.1266997280245, 4192.580741925844, 4207.410962465257, 4272.252355837716, 4273.658107351404, 4274.615284624399, 3837.0, 3841.0013396517106, 3848.191879705237, 3864.7681139131178, 3878.3600705883214, 5054.646174767805, 5064.518870707277, 5065.366829146356, 5071.467495912876, 5089.821856235014, 5259.658122222043, 5323.3079699639575, 5335.33308336458, 5440.537554307849, 5456.972715136399, 4905.3132561441425, 4988.6009119270375, 5016.44819069902, 5044.1677123274985, 5056.469070747518, 4610.631149508098, 4616.815327386934, 4625.930611040837, 4628.490866004737, 4709.670323077352, 5290.656107353087, 5353.625246232727, 5483.945160548423, 5488.506034456918, 5534.418886016911, 5282.947170528246, 5341.3857406398765, 5353.170258609922, 5356.785728570813, 5378.650387724785, 5357.276767636475, 5359.330083739533, 5359.705216213146, 5361.731913404392, 5380.542653874464, 5132.666376685504, 5187.98834227322, 5271.525562699376, 5297.655652382583, 5390.946090539202, 5282.049231138279, 5313.601479888946, 5440.455954404528, 5441.238226648352, 5488.0, 5310.309659744208, 5320.042392369411, 5336.893262134813, 5340.813071542478, 5342.332208473941, 5204.765785539584, 5259.289995850511, 5310.176922577007, 5311.814086506954, 5354.0, 5095.617828662791, 5236.659617124875, 5294.708791016377, 5300.681959082467, 5339.225812257123, 5304.443033481583, 5310.336207974004, 5340.465953404629, 5343.118385466354, 5399.5950303726595, 5063.113955057924, 5146.794128234828, 5231.89536209266, 5238.188080847474, 5242.842714718565], "unit": "score", "name": "dojo.html", "value": 4995.379650392588}, {"lowerIsBetter": false, "replicates": [550.3863192540318, 581.909803980383, 597.6862147372628, 601.2364297342375, 605.5458406195354, 27725.445491090166, 28335.149945501642, 32530.837345813266, 32853.34293314132, 32899.50650740241, 38259.0, 38747.806260968726, 38868.222635547274, 38875.0, 38954.0, 8391.076981532042, 8514.744557663249, 8575.871361929576, 8578.828423431527, 8591.35564832637, 8352.791180220482, 8474.23731864132, 8498.19267169621, 8505.234528892399, 8514.70198543051, 8603.655853765842, 8628.223459888608, 8694.608742606566, 8700.825983480327, 8702.608382622766, 8617.870731939025, 8637.611307491177, 8690.174433428814, 8701.0, 8705.869411958794, 8494.277986371166, 8634.481931084156, 8650.178233067849, 8658.437201581877, 8661.393702440831, 38012.23975520474, 38563.75798662145, 38594.0, 38674.41988370177, 38675.61324386748, 3360.1935535471557, 3399.7960122392738, 3410.7271418286477, 3508.491268766015, 3518.5074089627215, 28975.42049159026, 29348.0, 29372.8531357344, 29618.111456656334, 30423.391532169233, 3496.30073985204, 3521.6654417830264, 3590.2281009582803, 3609.747317687763, 3632.945505817415, 256979.0, 258240.0, 258443.0, 258660.0, 260219.69890150617, 51621.0, 52400.475995240326, 52432.0, 52757.0, 52841.735791320796, 62721.37278627246, 63157.0, 63650.36349636537, 63672.36327636665, 63780.36219637744, 15398.230088495531, 15690.607734806721, 15713.607159821097, 15720.606984825243, 15723.68552628941, 9264.39781414206, 9459.716208513755, 11242.94378528102, 12083.093767967437, 12158.452869620889, 18789.436316910516, 19000.23999040023, 19742.60514789696, 19895.0, 19939.30515906135, 7144.285571442918, 7345.449091318173, 7373.0, 7463.328300452985, 7532.359749421361, 888.9244414224734, 903.4759839293195, 1070.577122036791, 1077.8167711489066, 1134.1777211521746, 28120.29699257535, 28642.0, 28883.56674649882, 28926.27684307867, 30272.84863575668, 1019.7807471393686, 1025.4565080507343, 1034.736142283728, 1064.6114168328504, 1080.8486811846349, 14235.64410889736, 14268.85731142696, 14346.784798228035, 14544.0, 14685.265736713336, 341994.0, 348070.0, 348129.0, 348415.0, 348656.0, 51758.482415175364, 52009.479905201224, 52045.73977130166, 52066.0, 52137.2179417309, 1347.1512946843427, 1364.501956785766, 1371.067673981702, 1377.9596404714378, 1386.057480912989, 27010.72989270161, 28059.43881122407, 28144.43711125807, 28448.57327140053, 29413.264668382606, 43337.78331108324, 43579.782101089295, 43627.127457450035, 43723.12553748971, 43763.0, 215657.0, 216001.0, 216633.0, 216994.0, 217069.0, 28866.422671546872, 30923.0, 31512.36975260436, 31900.361992760478, 32004.0, 37607.43588846115, 37997.24005519819, 38198.045048874, 38243.617563824, 39098.0, 32108.839455803507, 33167.33665326728, 34288.828555857064, 34441.0, 35088.0, 34912.47631285482, 34916.30167396689, 35187.0, 35398.115047124025, 35466.29067418689, 33597.83201083979, 34237.657623423445, 34349.48475772915, 34389.484157737155, 34451.0, 29961.850190748908, 31211.375772484877, 31856.362872741953, 31905.0, 31961.520577190895, 23893.163739269043, 23970.0, 23992.520149597258, 24035.75964240335, 24258.63612045856], "unit": "score", "name": "ext.html", "value": 17794.661807794713}, {"lowerIsBetter": false, "replicates": [338.0871646554304, 355.26105700143705, 355.98932032039033, 356.0582259922505, 356.78057994333477, 12662.810057849128, 16132.838671613295, 16969.151542422893, 17729.96105447874, 17755.37856175034, 15671.764923526156, 15779.28993195306, 16507.33970641173, 16627.916860415713, 16735.497935061936, 3968.8412463501427, 4141.79291035447, 4145.647619952308, 5146.562542183919, 5353.411124776271, 4067.4102255172984, 4514.4582650081875, 5917.55618328627, 5921.585489015771, 5923.318818335903, 5098.464661210575, 5324.92012619811, 5868.0, 5872.61827981182, 5881.67650779207, 5176.767045482962, 5222.268882356435, 5225.634205605628, 5225.895482090375, 5230.163173892178, 4988.276699878534, 5003.3495645565845, 5014.398272207322, 5016.44819069902, 5022.070916880389, 14214.431422743079, 19428.12573434199, 20161.8991905041, 20170.39488815323, 20415.081321340425, 2069.3998740365278, 2094.8743075415373, 2104.5475222827167, 2225.1321984426086, 2310.4685922237813, 9514.33399662024, 9560.856587151198, 9656.662016829378, 9724.513774311326, 12166.756664866742, 1770.7343898415213, 1780.1366337326385, 1814.3468351393487, 1814.5826459914294, 1859.711744679577, 54824.0, 55028.0, 55565.0, 55983.0, 56838.0, 8972.730818075468, 9268.25853931684, 9513.429194248367, 10002.099601075772, 10146.746331341776, 12658.177218480954, 12697.301648409426, 12742.745145097046, 12752.80870786939, 12777.744445111046, 7643.808904777425, 7669.271419215165, 7763.107242667165, 7825.060992680915, 7838.451308408471, 7722.806929826799, 7787.29914307715, 7790.220977902164, 7814.101378341564, 7847.058352997677, 4432.15789000089, 4448.755318457451, 4461.5092339842595, 4474.574915383034, 4498.347739577808, 1807.5842556212144, 1829.2500074969198, 1829.3962992212537, 1835.4493651904643, 1835.577817102074, 420.78539944627846, 429.3559660509236, 468.0475232901098, 967.6516454076527, 1055.2824079625927, 10345.74135646615, 10981.505832237568, 10994.670159895217, 11086.833697494383, 11266.380349080879, 418.1928877266904, 422.7019950934584, 447.5502120369008, 463.2703492000113, 465.1371705486342, 5980.431858973478, 6082.604630699079, 6158.507319414436, 6209.316975132731, 6219.502439804804, 299350.0, 300459.0, 301221.0, 301308.0, 301392.0, 71546.28453715396, 72175.27824721791, 72488.0, 72819.0, 75315.0, 1118.6588090632272, 1148.6439203846835, 1158.5829101523445, 1165.8717541070305, 1169.1114752787942, 12589.559365422167, 14320.713585728436, 14363.0, 14597.854021460074, 14949.551513454613, 30536.236594085327, 30544.236394090327, 30664.84667576648, 31483.685163148075, 32198.35603287968, 34985.65014349824, 35281.647183527835, 35381.46927796137, 35513.82243088768, 35882.64117358898, 6339.746410143543, 6675.699593518206, 7088.787336379917, 7197.388222000979, 7342.3758980487255, 7957.482763620346, 11275.267107637977, 11404.201705880509, 11497.1377146716, 11870.0, 9623.518824058909, 9754.170895473964, 9948.45283509414, 10011.199104071802, 10058.949705251427, 7728.690852365842, 10102.797944041225, 10179.898201018192, 10284.794304114026, 10535.42055186972, 3168.588083549124, 3171.555982162453, 10141.949290253502, 10142.869997300355, 10566.471676415995, 6151.477124444473, 7290.088738907637, 7313.597752123685, 7735.342495887912, 7766.611669416619, 9800.411975281506, 9986.151177150025, 10176.847347289648, 10325.32885362449, 10366.652335196377], "unit": "score", "name": "jquery.html", "value": 7453.231710235099}, {"lowerIsBetter": false, "replicates": [1303.2441184113216, 1451.0, 1457.7886206500057, 1602.8557429831312, 1752.8860624059434, 6759.324067593238, 7440.144383395911, 7594.202608726087, 7594.24057594241, 7598.544087354749, 7325.340719335259, 7489.063867016623, 7531.09626844778, 7540.095188577365, 7550.282723141293, 1991.0442987366073, 2030.5126769575343, 2033.613613413454, 2312.826538009652, 2340.8946597403155, 2085.103405535619, 2321.1991862807304, 2350.882455877208, 2355.5995480768224, 2357.799587035104, 2261.694671219389, 2267.2178098556055, 2298.0, 2304.2626359564947, 2348.56551537966, 2293.3693234360517, 2317.0731707317123, 2318.7797159269926, 2323.1288266899915, 2325.38377330006, 2324.6164382876805, 2330.2310237621546, 2330.2892617751577, 2331.75516570761, 2337.590921588715, 7617.961910190414, 7641.23587641237, 7643.770686879402, 7652.617369131521, 7663.080430348338, 4728.71627702339, 4802.423709154924, 4839.516048395168, 4841.830535931225, 4842.055799119174, 2947.336849208932, 2950.8967186148598, 3037.1951432870305, 3042.5284080967485, 3048.0551029181024, 976.5556671714353, 1010.1464262698008, 1024.71820249432, 1030.2839526529065, 1065.1265961911236, 10479.633212837514, 10513.684589462327, 10517.474126293655, 10544.736381590445, 10552.683419497427, 4376.431063961664, 4400.317950717644, 4469.687121901501, 4474.172278128557, 4493.303537951622, 9157.633694652273, 9160.496172710431, 9165.129312715282, 9183.0, 9190.356675032817, 4917.409910810726, 4927.5811556017425, 4943.036107958986, 4945.060438516743, 4948.257761335756, 4434.135343607965, 4493.28107502798, 4500.3249512573375, 4503.0, 4506.0, 3426.3489936911906, 3470.132466883279, 3677.8896633100517, 3794.3739283017994, 3805.5729101586903, 1105.303658695017, 1201.7296108375544, 1218.6709588411256, 1223.2171410297417, 1237.1216436330126, 1283.6020833541631, 1294.779887419141, 1298.5455090718362, 1318.1168617026615, 1341.684704094537, 6998.230194678581, 7027.0, 7072.858542829114, 7090.893636595455, 7133.964330178316, 1091.7052395853075, 1106.6679996001167, 1119.8712148103073, 1120.3501968858043, 1120.506976930148, 5710.2862142232225, 5743.62666426681, 5756.856078598069, 5761.308642962871, 5764.13537969308, 9213.12475314844, 9263.397879137834, 9267.53662316895, 9283.535823208813, 9390.107939745712, 9211.76970575741, 9338.626454941726, 9342.813143737223, 9350.298727595458, 9351.205147562534, 7214.49498535108, 7215.855682886313, 7265.600391978492, 7376.557406555624, 7395.741149059864, 7078.398336141486, 7099.432045436456, 7102.4673149512955, 7104.751333703295, 7110.964445177741, 8226.42415030966, 8348.37387195975, 8379.316371626226, 8500.0, 8519.574021299035, 8607.225349718556, 8687.174718401742, 8795.824083518166, 8795.956020220114, 8807.427517211361, 6580.8354791130605, 6817.693203805741, 6822.454203663794, 6826.41975432074, 6836.726530938906, 6433.420992110732, 6583.80248592543, 6793.320667933167, 7305.963470182615, 7316.670749816165, 6678.465722742266, 6697.564658297195, 6770.492213084137, 6793.558418702769, 6869.381755642016, 6629.867402651824, 6667.8666426670225, 6678.365555272241, 6777.491688123312, 6795.3204679531655, 6834.692438840363, 6863.828404289933, 6884.724611015704, 6888.758893438706, 6889.311068893071, 6207.34822843613, 6317.778877739257, 6356.904646430215, 6394.4564712, 6397.776077837253, 6434.195725534309, 6571.934280657132, 6574.539782215199, 6588.571742836701, 6592.538522303585], "unit": "score", "name": "mootools.html", "value": 4480.139645025038}, {"lowerIsBetter": false, "replicates": [333.54138060167264, 335.3025706530417, 340.6933759616347, 345.37831902575357, 346.7815276375881, 5798.420157984205, 5800.100984347422, 5806.390329015446, 5814.738336774844, 5817.505512031477, 5537.723113844302, 5572.0, 5661.179129026289, 5725.656460612356, 5814.883702325961, 4451.799669014902, 4475.977620111911, 4481.327800829886, 4486.394336764536, 4490.191765482212, 4288.69979101463, 4488.124815660947, 4528.7056341337875, 4535.387722657449, 4545.52272011439, 4298.935515967263, 4307.978460107695, 4373.868783936471, 4398.472183338004, 4404.163208990298, 4378.737275763448, 4384.780760961971, 4394.4287242658565, 4405.140997505488, 4409.162259170764, 3876.5154355705536, 3877.2245550889934, 3887.5140607424073, 3897.4543563901075, 3929.5088113985753, 5503.367112782002, 5548.55611551075, 5557.305336832896, 5561.63849349791, 5563.860903477405, 5225.19009553516, 5274.604404669627, 5278.023565640369, 5283.365996080495, 5287.0, 6172.59878107926, 6176.104464852571, 6184.165137706397, 6190.576167481459, 6200.441960223601, 4415.050764085705, 4431.446069241345, 4434.401355816955, 4440.200763862504, 4453.977730111361, 6347.0, 6361.045843123568, 6431.485481161542, 6452.548321617535, 6460.160179176677, 4513.277875539898, 4518.344839998182, 4519.0, 4521.660875434355, 4523.411956445641, 4580.061087477059, 4580.427446569179, 4584.7936842842155, 4587.059652771174, 4587.72473651582, 5224.52979231871, 5232.03207406631, 5234.0, 5234.869128271824, 5241.292425522582, 6002.0, 6208.4722798561725, 6211.819754246679, 6225.252969643581, 6238.344973777779, 1610.7664388663577, 1631.3719218101116, 1632.5347276026275, 1634.632207753246, 1634.991825040891, 1089.1123734156638, 1092.8415379769888, 1111.7609713911547, 1116.430620383594, 1137.766757814646, 5751.0, 5768.625039372428, 5800.88398232033, 5813.59304848665, 5826.0678291474005, 6328.968355158195, 6349.55553111287, 6351.079093531412, 6357.682115894187, 6363.077353783768, 5614.522765564891, 5713.285839270091, 5714.371419143891, 5717.999350113713, 5736.942630573724, 3409.232922592397, 3448.3103379324234, 3450.240946991708, 3450.7929524228625, 3456.9654303457146, 6568.014797780275, 6569.770058047945, 6578.76974305897, 6589.374009469188, 6589.7364105435245, 6368.203974503187, 6554.606723596599, 6558.803235902835, 6566.8358291043105, 6593.7362505500205, 6494.155759751202, 6515.706793194412, 6516.771912983023, 6520.054592084121, 6531.542792004514, 6361.232863704304, 6428.646424446513, 6430.935690643034, 6431.549791514736, 6437.163168788027, 6189.84525386869, 6366.331535188739, 6373.267074286331, 6379.393957574023, 6394.552381333262, 6592.406683398325, 6598.736050557924, 6600.768973085919, 6609.669516524251, 6612.371824676648, 4344.826206951813, 4350.673699472489, 4370.934435983399, 4389.253826849507, 4390.670699697472, 6234.812955611339, 6433.324500927522, 6436.581622194542, 6436.935630643634, 6439.0, 6221.035739460391, 6232.407921247474, 6249.593776404519, 6264.154339164154, 6269.373062693694, 6251.46862516673, 6263.74945002213, 6264.2796078451565, 6265.655388953469, 6266.248050234001, 5929.288485381781, 6142.385761423822, 6151.6001459904965, 6157.0456579230295, 6168.290646575521, 6284.24589049317, 6290.150829637941, 6290.716917738804, 6292.528060395397, 6298.590591611531, 6074.757009719562, 6129.111278864629, 6151.446369826737, 6152.692365381624, 6162.137300777984], "unit": "score", "name": "prototype.html", "value": 4690.615985917811}, {"lowerIsBetter": false, "replicates": [767.9654415551303, 793.0562630469741, 819.3199644295236, 853.5476197615262, 856.7943693513556, 11771.470283837227, 11962.521499140035, 11984.820227696591, 12003.399830008497, 12005.579804706837, 12503.624891253254, 12686.682832929182, 12702.23786572804, 12727.554535591256, 12729.554465593706, 810.4448452809814, 826.4008593769529, 826.7313123234973, 826.7478419082178, 826.9421140520166, 814.071957967917, 817.1134319263606, 817.4686453805015, 817.5952903312868, 817.709713051867, 845.18439705684, 847.076686411811, 848.0163010907348, 848.0586548930713, 848.0628905059913, 838.995805020974, 844.4004756622805, 844.9028361738417, 845.0830848529353, 845.9365547583925, 628.2021832273033, 629.7984644913629, 629.9244090709144, 631.0471188505344, 632.2476253258653, 13335.799963000563, 13364.13133146352, 13380.0, 13470.932645336808, 13504.257265850374, 12782.360881955958, 12868.485260589565, 12878.098533102686, 12939.5471158509, 13062.54281100157, 10445.529951152217, 10458.320209186379, 10623.893761062367, 10760.11697952863, 11088.112950963903, 4088.1414902870433, 4197.517285512175, 4223.282042052859, 4224.408582798411, 4244.511881133678, 37259.0, 41526.792366037975, 41556.376654350206, 41836.0, 44370.334444983026, 9839.901600983898, 9904.950475247577, 9908.950455247677, 10037.0, 10206.438645874548, 16227.594310142342, 16344.918275408785, 16400.0, 16829.074400907823, 16834.326626934784, 7508.887366689504, 7516.323530882138, 7586.203448637924, 7638.770836874903, 7746.49647772893, 4391.956080439155, 4402.141582391403, 4442.711223770445, 4452.510223875371, 4486.484054333728, 3107.083410393939, 3116.703913128249, 3127.405792899342, 3128.7340576050833, 3133.2950086230417, 547.9726013699379, 557.8744782423922, 570.785955266775, 574.4657468554201, 589.9882002359928, 503.62983207342575, 555.5500044963593, 581.9621724587888, 665.8801415745115, 683.0744341417308, 8841.778955526162, 8857.29141668665, 8961.327900407496, 8982.461052336881, 9074.727758167266, 649.9834288851855, 669.263809809206, 672.1463741048841, 675.2133764164792, 704.1936982155403, 4003.939940900889, 4007.8597249096724, 4148.191102734938, 4168.937465938014, 4183.184279065553, 58171.545711357554, 60066.09900851491, 60133.69933150306, 60218.0, 60237.0, 50663.7466812671, 51341.0, 51744.0, 51894.48105518972, 52388.73805630948, 40923.59076409257, 42018.15963680709, 45013.77493112513, 45230.0, 48796.02407951821, 9138.406003609743, 9264.675736349196, 9303.581338839633, 9317.580708867981, 9358.719238422858, 34750.13124671904, 35382.0, 35515.46726799152, 36035.27929441344, 36185.0, 39272.214555709295, 39322.6067739319, 41932.58067419287, 42231.366529501465, 50159.74920125376, 10393.84409233847, 10493.422861742678, 11454.255473394203, 11478.598249061242, 11869.050475961729, 12374.257544547356, 12576.427946506687, 12598.937005314914, 12885.162464439782, 13323.933380333036, 11496.195266331611, 11590.710232243924, 11777.0, 12041.759164816829, 12444.191127576678, 11617.244879082833, 11637.359945202756, 12012.099092568267, 12033.518659253532, 12447.875521244672, 10343.844842327522, 10598.20513461478, 10612.734681633021, 11001.779964400506, 11123.666290011313, 8774.210321071134, 8971.690154204034, 9054.32092593045, 9134.908650913672, 9161.450312981242, 9218.52503599421, 9365.953170234105, 10044.497775111362, 10046.69859904204, 10171.084602385821], "unit": "score", "name": "yui.html", "value": 6314.563548249779}], "name": "dromaeo_css", "value": 6668.335800150312}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 108.0, 111.0, 111.0, 114.0, 102.0, 111.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 149.0, 163.0, 128.0, 152.0, 159.0, 123.0, 164.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 159.0, 163.0, 162.0, 159.0, 159.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 86.0, 89.0, 75.0, 71.0, 75.0, 115.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 140.0, 95.0, 96.0, 96.0, 139.0, 95.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 55.0, 56.0, 54.0, 55.0, 64.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 71.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 84.0, 85.0, 86.0, 87.0, 86.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 119.0, 130.0, 116.0, 133.0, 117.0, 126.0, 118.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [144.0, 143.0, 168.0, 151.0, 142.0, 158.0, 158.0, 163.0, 149.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.7}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 68.0, 72.0, 70.0, 76.0, 67.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1511.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [191.05846388995033], "unit": "score", "name": "DeltaBlue", "value": 346.061612}, {"lowerIsBetter": false, "replicates": [283.04557033682426], "unit": "score", "name": "Encrypt", "value": 940.4174729999997}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1106.1946902654868], "unit": "score", "name": "RayTrace", "value": 668.9500559999998}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [42957.44680851064], "unit": "score", "name": "RegExp", "value": 21.20668400198118}, {"lowerIsBetter": false, "replicates": [606.060606060606], "unit": "score", "name": "Splay", "value": 134.46015000000003}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19964.295695428053}]} 09:14:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19964.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1511.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6668.34"}}} 09:14:47 INFO - Return code: 0 09:14:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:14:47 INFO - # TBPL SUCCESS # 09:14:47 INFO - Running post-action listener: _resource_record_post_action 09:14:47 INFO - Running post-run listener: _resource_record_post_run 09:14:48 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 331632640; Read time: 0; Write time: 233500 09:14:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 18530304; Read time: 0; Write time: 2456 09:14:48 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 313102336; Read time: 0; Write time: 231044 09:14:48 INFO - Running post-run listener: _upload_blobber_files 09:14:48 INFO - Blob upload gear active. 09:14:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:14:48 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 09:14:48 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:14:48 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:14:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:50 INFO - (blobuploader) - INFO - Done attempting. 09:14:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:51 INFO - (blobuploader) - INFO - Done attempting. 09:14:51 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:51 INFO - Return code: 0 09:14:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:14:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d4205037b32174c269db4f99b390e73b6b327f9b8627e4ebee3b12d3144f65e8f10bbf74880df871d0abac48a8a81eb129f0f9009abd2b0009d56e90fa159d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f90dc4ee80104cd98c803de6fc0d49130b30cabf574ac069676bbaaf8555375c68c70e3dc93ebffcb37b727f959dde2661573e92d389aff632d9d8d23831799"} 09:14:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:14:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:14:51 INFO - Contents: 09:14:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d4205037b32174c269db4f99b390e73b6b327f9b8627e4ebee3b12d3144f65e8f10bbf74880df871d0abac48a8a81eb129f0f9009abd2b0009d56e90fa159d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f90dc4ee80104cd98c803de6fc0d49130b30cabf574ac069676bbaaf8555375c68c70e3dc93ebffcb37b727f959dde2661573e92d389aff632d9d8d23831799"} 09:14:51 INFO - Copying logs to upload dir... 09:14:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.969372 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-11 09:14:50.453054) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 09:14:50.456134) ========= 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=4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d4205037b32174c269db4f99b390e73b6b327f9b8627e4ebee3b12d3144f65e8f10bbf74880df871d0abac48a8a81eb129f0f9009abd2b0009d56e90fa159d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f90dc4ee80104cd98c803de6fc0d49130b30cabf574ac069676bbaaf8555375c68c70e3dc93ebffcb37b727f959dde2661573e92d389aff632d9d8d23831799"} build_url:https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/RfIHTbiyTCaYyUhc8EN6xg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74d4205037b32174c269db4f99b390e73b6b327f9b8627e4ebee3b12d3144f65e8f10bbf74880df871d0abac48a8a81eb129f0f9009abd2b0009d56e90fa159d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f90dc4ee80104cd98c803de6fc0d49130b30cabf574ac069676bbaaf8555375c68c70e3dc93ebffcb37b727f959dde2661573e92d389aff632d9d8d23831799"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 09:14:50.481234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:14:50.481597) ========= 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=4dd8011cc2821079d74a932a000001ae-1452529936.615001-932121692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 09:14:50.566425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 09:14:50.566776) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 09:14:50.567094) ========= ========= Total master_lag: 0.24 =========