builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1451109384.67 results: success (0) buildid: 20151225193239 builduid: dd81fb5c080b4ecabe1686a46fd6ce36 revision: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.674046) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.674519) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.674803) ========= 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=256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006437 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.707956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.708267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.739449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.739703) ========= 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=256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.793812) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.794095) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.794452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.794725) ========= 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=256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 21:56: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% 43.5M=0s 2015-12-25 21:56:25 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.016744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.017348) ========= 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=256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017747 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.073338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.073673) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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=256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 21:56:25,329 truncating revision to first 12 chars 2015-12-25 21:56:25,330 Setting DEBUG logging. 2015-12-25 21:56:25,330 attempt 1/10 2015-12-25 21:56:25,330 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4a559a618d67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 21:56:25,670 unpacking tar archive at: mozilla-central-4a559a618d67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.726262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.726643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.774264) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.774646) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.777721) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-12-25 21:56:25.778028) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --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', '--system-bits', '64', '--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=256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:56:26 INFO - MultiFileLogger online at 20151225 21:56:26 in /builds/slave/test-pgo 21:56:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:56:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:56:26 INFO - {'append_to_log': False, 21:56:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:56:26 INFO - 'blob_upload_branch': 'Firefox', 21:56:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:56:26 INFO - 'branch': 'Firefox', 21:56:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:26 INFO - 'config_files': ('talos/linux_config.py',), 21:56:26 INFO - 'default_actions': ('clobber', 21:56:26 INFO - 'read-buildbot-config', 21:56:26 INFO - 'download-and-extract', 21:56:26 INFO - 'populate-webroot', 21:56:26 INFO - 'create-virtualenv', 21:56:26 INFO - 'install', 21:56:26 INFO - 'run-tests'), 21:56:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:26 INFO - 'download_minidump_stackwalk': True, 21:56:26 INFO - 'download_symbols': 'ondemand', 21:56:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:26 INFO - 'installer_path': 'installer.exe', 21:56:26 INFO - 'log_level': 'info', 21:56:26 INFO - 'log_name': 'talos', 21:56:26 INFO - 'log_to_console': True, 21:56:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:56:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:56:26 INFO - 'opt_config_files': (), 21:56:26 INFO - 'pip_index': False, 21:56:26 INFO - 'sps_profile': False, 21:56:26 INFO - 'sps_profile_interval': 0, 21:56:26 INFO - 'suite': 'dromaeojs', 21:56:26 INFO - 'system_bits': '64', 21:56:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:26 INFO - 'title': 'talos-linux64-ix-013', 21:56:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:26 INFO - 'use_talos_json': True, 21:56:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:56:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:26 INFO - 'work_dir': 'build'} 21:56:26 INFO - ##### 21:56:26 INFO - ##### Running clobber step. 21:56:26 INFO - ##### 21:56:26 INFO - Running pre-action listener: _resource_record_pre_action 21:56:26 INFO - Running main action method: clobber 21:56:26 INFO - rmtree: /builds/slave/test-pgo/build 21:56:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:56:26 INFO - Running post-action listener: _resource_record_post_action 21:56:26 INFO - ##### 21:56:26 INFO - ##### Running read-buildbot-config step. 21:56:26 INFO - ##### 21:56:26 INFO - Running pre-action listener: _resource_record_pre_action 21:56:26 INFO - Running main action method: read_buildbot_config 21:56:26 INFO - Using buildbot properties: 21:56:26 INFO - { 21:56:26 INFO - "project": "", 21:56:26 INFO - "product": "firefox", 21:56:26 INFO - "script_repo_revision": "production", 21:56:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:56:26 INFO - "repository": "", 21:56:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:56:26 INFO - "buildid": "20151225193239", 21:56:26 INFO - "pgo_build": "True", 21:56:26 INFO - "basedir": "/builds/slave/test-pgo", 21:56:26 INFO - "buildnumber": 616, 21:56:26 INFO - "slavename": "talos-linux64-ix-013", 21:56:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:56:26 INFO - "platform": "ubuntu64_hw", 21:56:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:56:26 INFO - "branch": "mozilla-central", 21:56:26 INFO - "repo_path": "mozilla-central", 21:56:26 INFO - "revision": "4a559a618d6798eb9a8fdc559f5a7a00085e2062", 21:56:26 INFO - "stage_platform": "linux64-pgo", 21:56:26 INFO - "builduid": "dd81fb5c080b4ecabe1686a46fd6ce36", 21:56:26 INFO - "slavebuilddir": "test" 21:56:26 INFO - } 21:56:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:56:26 INFO - Running post-action listener: _resource_record_post_action 21:56:26 INFO - ##### 21:56:26 INFO - ##### Running download-and-extract step. 21:56:26 INFO - ##### 21:56:26 INFO - Running pre-action listener: _resource_record_pre_action 21:56:26 INFO - Running main action method: download_and_extract 21:56:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:56: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')]} 21:56:26 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json 21:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json 21:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:56:30 INFO - Downloaded 1302 bytes. 21:56:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:56:30 INFO - Using the following test package requirements: 21:56:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:56:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:30 INFO - u'jsshell-linux-x86_64.zip'], 21:56:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:56:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:56:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:56:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:56:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:56:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:30 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:36 INFO - Downloaded 23191449 bytes. 21:56:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:56:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:56:37 INFO - Return code: 0 21:56:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:37 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:39 INFO - Downloaded 23191449 bytes. 21:56:39 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 21:56:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:39 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 21:56:40 INFO - Return code: 0 21:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:40 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:43 INFO - Downloaded 11132270 bytes. 21:56:43 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 21:56:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:43 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 21:56:43 INFO - Return code: 0 21:56:43 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')]} 21:56:43 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:44 INFO - Downloaded 54924771 bytes. 21:56:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:56:44 INFO - mkdir: /builds/slave/test-pgo/properties 21:56:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:56:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:56:44 INFO - Contents: 21:56:44 INFO - build_url:https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:56:44 INFO - Running post-action listener: _resource_record_post_action 21:56:44 INFO - Running post-action listener: set_extra_try_arguments 21:56:44 INFO - ##### 21:56:44 INFO - ##### Running populate-webroot step. 21:56:44 INFO - ##### 21:56:44 INFO - Running pre-action listener: _resource_record_pre_action 21:56:44 INFO - Running main action method: populate_webroot 21:56:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:44 INFO - '--tppagecycles', 21:56:44 INFO - '7'], 21:56:44 INFO - 'tests': ['tsvgm']}}, 21:56:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:56:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:56:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:56:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:44 INFO - 'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:44 INFO - 'tests': ['damp', 'tps']}, 21:56:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:44 INFO - 'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['damp', 'tps']}, 21:56:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:56:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:44 INFO - 'other': {'tests': ['a11yr', 21:56:44 INFO - 'ts_paint', 21:56:44 INFO - 'tpaint', 21:56:44 INFO - 'sessionrestore', 21:56:44 INFO - 'sessionrestore_no_auto_restore']}, 21:56:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['a11yr', 21:56:44 INFO - 'ts_paint', 21:56:44 INFO - 'tpaint', 21:56:44 INFO - 'sessionrestore', 21:56:44 INFO - 'sessionrestore_no_auto_restore']}, 21:56:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['a11yr', 21:56:44 INFO - 'ts_paint', 21:56:44 INFO - 'tpaint', 21:56:44 INFO - 'sessionrestore', 21:56:44 INFO - 'sessionrestore_no_auto_restore']}, 21:56:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['a11yr', 21:56:44 INFO - 'ts_paint', 21:56:44 INFO - 'tpaint', 21:56:44 INFO - 'sessionrestore', 21:56:44 INFO - 'sessionrestore_no_auto_restore']}, 21:56:44 INFO - 'other_l64': {'tests': ['a11yr', 21:56:44 INFO - 'ts_paint', 21:56:44 INFO - 'tpaint', 21:56:44 INFO - 'sessionrestore', 21:56:44 INFO - 'sessionrestore_no_auto_restore']}, 21:56:44 INFO - 'other_nol64': {'tests': ['a11yr', 21:56:44 INFO - 'ts_paint', 21:56:44 INFO - 'tpaint', 21:56:44 INFO - 'sessionrestore', 21:56:44 INFO - 'sessionrestore_no_auto_restore']}, 21:56:44 INFO - 'svgr': {'tests': ['tsvgx', 21:56:44 INFO - 'tsvgr_opacity', 21:56:44 INFO - 'tart', 21:56:44 INFO - 'tscrollx', 21:56:44 INFO - 'cart']}, 21:56:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['tsvgx', 21:56:44 INFO - 'tsvgr_opacity', 21:56:44 INFO - 'tart', 21:56:44 INFO - 'tscrollx', 21:56:44 INFO - 'cart']}, 21:56:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:44 INFO - 'tests': ['tp5o']}, 21:56:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:44 INFO - 'talos_options': ['--e10s'], 21:56:44 INFO - 'tests': ['tp5o']}, 21:56:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:44 INFO - 'talos_options': ['--xperf_path', 21:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:44 INFO - 'tests': ['tp5n']}, 21:56:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:44 INFO - 'talos_options': ['--e10s', 21:56:44 INFO - '--xperf_path', 21:56:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:44 INFO - 'tests': ['tp5n']}}, 21:56:44 INFO - 'talos.zip': {'path': '', 21:56:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:44 INFO - Running post-action listener: _resource_record_post_action 21:56:44 INFO - ##### 21:56:44 INFO - ##### Running create-virtualenv step. 21:56:44 INFO - ##### 21:56:44 INFO - Running pre-action listener: _resource_record_pre_action 21:56:44 INFO - Running main action method: create_virtualenv 21:56:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:56:44 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 21:56:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:56:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:44 INFO - Using real prefix '/usr' 21:56:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:56:45 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:47 INFO - Installing pip.................done. 21:56:47 INFO - Return code: 0 21:56:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:56:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:56:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:56:47 INFO - Using env: {'DISPLAY': ':0', 21:56:47 INFO - 'HOME': '/home/cltbld', 21:56:47 INFO - 'LANG': 'en_US.UTF-8', 21:56:47 INFO - 'LANGUAGE': 'en_US:en', 21:56:47 INFO - 'LOGNAME': 'cltbld', 21:56:47 INFO - 'MAIL': '/var/mail/cltbld', 21:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:47 INFO - 'MOZ_NO_REMOTE': '1', 21:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:47 INFO - 'NO_EM_RESTART': '1', 21:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:47 INFO - 'SHELL': '/bin/bash', 21:56:47 INFO - 'SHLVL': '1', 21:56:47 INFO - 'TERM': 'linux', 21:56:47 INFO - 'TMOUT': '86400', 21:56:47 INFO - 'USER': 'cltbld', 21:56:47 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:47 INFO - '_': '/tools/buildbot/bin/python'} 21:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:47 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 21:56:47 INFO - Cleaning up... 21:56:47 INFO - Return code: 0 21:56:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:56:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:56:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:56:47 INFO - Using env: {'DISPLAY': ':0', 21:56:47 INFO - 'HOME': '/home/cltbld', 21:56:47 INFO - 'LANG': 'en_US.UTF-8', 21:56:47 INFO - 'LANGUAGE': 'en_US:en', 21:56:47 INFO - 'LOGNAME': 'cltbld', 21:56:47 INFO - 'MAIL': '/var/mail/cltbld', 21:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:47 INFO - 'MOZ_NO_REMOTE': '1', 21:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:47 INFO - 'NO_EM_RESTART': '1', 21:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:47 INFO - 'SHELL': '/bin/bash', 21:56:47 INFO - 'SHLVL': '1', 21:56:47 INFO - 'TERM': 'linux', 21:56:47 INFO - 'TMOUT': '86400', 21:56:47 INFO - 'USER': 'cltbld', 21:56:47 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:47 INFO - '_': '/tools/buildbot/bin/python'} 21:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:47 INFO - Downloading/unpacking psutil>=0.7.1 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:56:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:56:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:49 INFO - Installing collected packages: psutil 21:56:49 INFO - Running setup.py install for psutil 21:56:49 INFO - building 'psutil._psutil_linux' extension 21:56:49 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 21:56:49 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 21:56:49 INFO - building 'psutil._psutil_posix' extension 21:56:49 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 21:56:50 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 21:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:50 INFO - Successfully installed psutil 21:56:50 INFO - Cleaning up... 21:56:50 INFO - Return code: 0 21:56:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:50 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 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:56:50 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 21:56:50 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 21:56:50 INFO - Using env: {'DISPLAY': ':0', 21:56:50 INFO - 'HOME': '/home/cltbld', 21:56:50 INFO - 'LANG': 'en_US.UTF-8', 21:56:50 INFO - 'LANGUAGE': 'en_US:en', 21:56:50 INFO - 'LOGNAME': 'cltbld', 21:56:50 INFO - 'MAIL': '/var/mail/cltbld', 21:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:50 INFO - 'MOZ_NO_REMOTE': '1', 21:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:50 INFO - 'NO_EM_RESTART': '1', 21:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:50 INFO - 'SHELL': '/bin/bash', 21:56:50 INFO - 'SHLVL': '1', 21:56:50 INFO - 'TERM': 'linux', 21:56:50 INFO - 'TMOUT': '86400', 21:56:50 INFO - 'USER': 'cltbld', 21:56:50 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:50 INFO - '_': '/tools/buildbot/bin/python'} 21:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:56:50 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 21:56:50 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 21:56:50 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 21:56:50 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 21:56:50 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 21:56:50 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 21:56:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:56:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:56:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:56:52 INFO - Installing collected packages: mozsystemmonitor 21:56:52 INFO - Running setup.py install for mozsystemmonitor 21:56:52 INFO - Successfully installed mozsystemmonitor 21:56:52 INFO - Cleaning up... 21:56:52 INFO - Return code: 0 21:56:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:52 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 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:56:52 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 21:56:52 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 21:56:52 INFO - Using env: {'DISPLAY': ':0', 21:56:52 INFO - 'HOME': '/home/cltbld', 21:56:52 INFO - 'LANG': 'en_US.UTF-8', 21:56:52 INFO - 'LANGUAGE': 'en_US:en', 21:56:52 INFO - 'LOGNAME': 'cltbld', 21:56:52 INFO - 'MAIL': '/var/mail/cltbld', 21:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:52 INFO - 'MOZ_NO_REMOTE': '1', 21:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:52 INFO - 'NO_EM_RESTART': '1', 21:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:52 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:52 INFO - 'SHELL': '/bin/bash', 21:56:52 INFO - 'SHLVL': '1', 21:56:52 INFO - 'TERM': 'linux', 21:56:52 INFO - 'TMOUT': '86400', 21:56:52 INFO - 'USER': 'cltbld', 21:56:52 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:52 INFO - '_': '/tools/buildbot/bin/python'} 21:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:56:52 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 21:56:52 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 21:56:52 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 21:56:52 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 21:56:52 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 21:56:52 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 21:56:54 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:56:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:56:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:56:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:54 INFO - Downloading docopt-0.6.1.tar.gz 21:56:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:56:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:54 INFO - Running setup.py install for blobuploader 21:56:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:56:54 INFO - Running setup.py install for requests 21:56:55 INFO - Running setup.py install for docopt 21:56:55 INFO - Successfully installed blobuploader requests docopt 21:56:55 INFO - Cleaning up... 21:56:55 INFO - Return code: 0 21:56:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:55 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')]} 21:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:55 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')]} 21:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:55 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 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:56:55 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 21:56:55 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 21:56:55 INFO - Using env: {'DISPLAY': ':0', 21:56:55 INFO - 'HOME': '/home/cltbld', 21:56:55 INFO - 'LANG': 'en_US.UTF-8', 21:56:55 INFO - 'LANGUAGE': 'en_US:en', 21:56:55 INFO - 'LOGNAME': 'cltbld', 21:56:55 INFO - 'MAIL': '/var/mail/cltbld', 21:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:55 INFO - 'MOZ_NO_REMOTE': '1', 21:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:55 INFO - 'NO_EM_RESTART': '1', 21:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:55 INFO - 'SHELL': '/bin/bash', 21:56:55 INFO - 'SHLVL': '1', 21:56:55 INFO - 'TERM': 'linux', 21:56:55 INFO - 'TMOUT': '86400', 21:56:55 INFO - 'USER': 'cltbld', 21:56:55 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:55 INFO - '_': '/tools/buildbot/bin/python'} 21:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:55 INFO - Running setup.py (path:/tmp/pip-87PRQ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:55 INFO - Running setup.py (path:/tmp/pip-_u98mD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:55 INFO - Running setup.py (path:/tmp/pip-kl_PEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:55 INFO - Running setup.py (path:/tmp/pip-R_zYTz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:55 INFO - Running setup.py (path:/tmp/pip-sLJOXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:56 INFO - Running setup.py (path:/tmp/pip-xsqQxS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:56 INFO - Running setup.py (path:/tmp/pip-Na8lFI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:56 INFO - Running setup.py (path:/tmp/pip-8ZTbBh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:56 INFO - Running setup.py (path:/tmp/pip-z2jf9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:56 INFO - Running setup.py (path:/tmp/pip-_T4qCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:56 INFO - Running setup.py (path:/tmp/pip-2nEANh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:56 INFO - Running setup.py (path:/tmp/pip-AeYnuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:56 INFO - Running setup.py (path:/tmp/pip-FCsx_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:56 INFO - Running setup.py (path:/tmp/pip-U59DLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:56 INFO - Running setup.py (path:/tmp/pip-JyL30r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:56 INFO - Running setup.py (path:/tmp/pip-vmJfJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:56 INFO - Running setup.py (path:/tmp/pip-cFWBUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:56 INFO - Running setup.py install for manifestparser 21:56:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:56:56 INFO - Running setup.py install for mozcrash 21:56:57 INFO - Running setup.py install for mozdebug 21:56:57 INFO - Running setup.py install for mozdevice 21:56:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Running setup.py install for mozfile 21:56:57 INFO - Running setup.py install for mozhttpd 21:56:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Running setup.py install for mozinfo 21:56:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Running setup.py install for mozInstall 21:56:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Running setup.py install for mozleak 21:56:57 INFO - Running setup.py install for mozlog 21:56:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Running setup.py install for moznetwork 21:56:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:56:57 INFO - Running setup.py install for mozprocess 21:56:58 INFO - Running setup.py install for mozprofile 21:56:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:56:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:56:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:56:58 INFO - Running setup.py install for mozrunner 21:56:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:56:58 INFO - Running setup.py install for mozscreenshot 21:56:58 INFO - Running setup.py install for moztest 21:56:58 INFO - Running setup.py install for mozversion 21:56:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:56:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:58 INFO - Cleaning up... 21:56:58 INFO - Return code: 0 21:56:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56: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')]} 21:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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')]} 21:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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', '-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 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:56:58 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 21:56:58 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 21:56:58 INFO - Using env: {'DISPLAY': ':0', 21:56:58 INFO - 'HOME': '/home/cltbld', 21:56:58 INFO - 'LANG': 'en_US.UTF-8', 21:56:58 INFO - 'LANGUAGE': 'en_US:en', 21:56:58 INFO - 'LOGNAME': 'cltbld', 21:56:58 INFO - 'MAIL': '/var/mail/cltbld', 21:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:58 INFO - 'MOZ_NO_REMOTE': '1', 21:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:58 INFO - 'NO_EM_RESTART': '1', 21:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:58 INFO - 'SHELL': '/bin/bash', 21:56:58 INFO - 'SHLVL': '1', 21:56:58 INFO - 'TERM': 'linux', 21:56:58 INFO - 'TMOUT': '86400', 21:56:58 INFO - 'USER': 'cltbld', 21:56:58 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:58 INFO - '_': '/tools/buildbot/bin/python'} 21:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:58 INFO - Running setup.py (path:/tmp/pip-2K3UDo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:58 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)) 21:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:58 INFO - Running setup.py (path:/tmp/pip-nxvMfm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:59 INFO - Running setup.py (path:/tmp/pip-04Bv8W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:59 INFO - Running setup.py (path:/tmp/pip-KLaWH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:59 INFO - Running setup.py (path:/tmp/pip-9Gxcjq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:59 INFO - Running setup.py (path:/tmp/pip-Kpx6qW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:59 INFO - Running setup.py (path:/tmp/pip-CQzGVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:59 INFO - Running setup.py (path:/tmp/pip-SuzYg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:59 INFO - Running setup.py (path:/tmp/pip-vlPvbv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:59 INFO - Running setup.py (path:/tmp/pip-q6qoje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:59 INFO - Running setup.py (path:/tmp/pip-PKzbmE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:59 INFO - Running setup.py (path:/tmp/pip-2TSxmC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:59 INFO - Running setup.py (path:/tmp/pip-GX7I5O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:59 INFO - Running setup.py (path:/tmp/pip-kt_M1C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:59 INFO - Running setup.py (path:/tmp/pip-qcqMEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:59 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)) 21:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:59 INFO - Running setup.py (path:/tmp/pip-F02AZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:00 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)) 21:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:00 INFO - Running setup.py (path:/tmp/pip-ulQh76-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:00 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)) 21:57:00 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)) 21:57:00 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)) 21:57:00 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)) 21:57:00 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)) 21:57:00 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)) 21:57:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:01 INFO - Downloading blessings-1.5.1.tar.gz 21:57:01 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 21:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:57:01 INFO - Installing collected packages: blessings 21:57:01 INFO - Running setup.py install for blessings 21:57:01 INFO - Successfully installed blessings 21:57:01 INFO - Cleaning up... 21:57:02 INFO - Return code: 0 21:57:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:57:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:02 INFO - Reading from file tmpfile_stdout 21:57:02 INFO - Current package versions: 21:57:02 INFO - argparse == 1.2.1 21:57:02 INFO - blessings == 1.5.1 21:57:02 INFO - blobuploader == 1.2.4 21:57:02 INFO - docopt == 0.6.1 21:57:02 INFO - manifestparser == 1.1 21:57:02 INFO - mozInstall == 1.12 21:57:02 INFO - mozcrash == 0.16 21:57:02 INFO - mozdebug == 0.1 21:57:02 INFO - mozdevice == 0.47 21:57:02 INFO - mozfile == 1.2 21:57:02 INFO - mozhttpd == 0.7 21:57:02 INFO - mozinfo == 0.9 21:57:02 INFO - mozleak == 0.1 21:57:02 INFO - mozlog == 3.1 21:57:02 INFO - moznetwork == 0.27 21:57:02 INFO - mozprocess == 0.22 21:57:02 INFO - mozprofile == 0.28 21:57:02 INFO - mozrunner == 6.11 21:57:02 INFO - mozscreenshot == 0.1 21:57:02 INFO - mozsystemmonitor == 0.0 21:57:02 INFO - moztest == 0.7 21:57:02 INFO - mozversion == 1.4 21:57:02 INFO - psutil == 3.1.1 21:57:02 INFO - requests == 1.2.3 21:57:02 INFO - wsgiref == 0.1.2 21:57:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:57:02 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 21:57:02 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 21:57:02 INFO - Using env: {'DISPLAY': ':0', 21:57:02 INFO - 'HOME': '/home/cltbld', 21:57:02 INFO - 'LANG': 'en_US.UTF-8', 21:57:02 INFO - 'LANGUAGE': 'en_US:en', 21:57:02 INFO - 'LOGNAME': 'cltbld', 21:57:02 INFO - 'MAIL': '/var/mail/cltbld', 21:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:02 INFO - 'MOZ_NO_REMOTE': '1', 21:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:02 INFO - 'NO_EM_RESTART': '1', 21:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:02 INFO - 'SHELL': '/bin/bash', 21:57:02 INFO - 'SHLVL': '1', 21:57:02 INFO - 'TERM': 'linux', 21:57:02 INFO - 'TMOUT': '86400', 21:57:02 INFO - 'USER': 'cltbld', 21:57:02 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:02 INFO - '_': '/tools/buildbot/bin/python'} 21:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 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)) 21:57:02 INFO - Cleaning up... 21:57:02 INFO - Return code: 0 21:57:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:57:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 21:57:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:57:02 INFO - Using env: {'DISPLAY': ':0', 21:57:02 INFO - 'HOME': '/home/cltbld', 21:57:02 INFO - 'LANG': 'en_US.UTF-8', 21:57:02 INFO - 'LANGUAGE': 'en_US:en', 21:57:02 INFO - 'LOGNAME': 'cltbld', 21:57:02 INFO - 'MAIL': '/var/mail/cltbld', 21:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:02 INFO - 'MOZ_NO_REMOTE': '1', 21:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:02 INFO - 'NO_EM_RESTART': '1', 21:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:02 INFO - 'SHELL': '/bin/bash', 21:57:02 INFO - 'SHLVL': '1', 21:57:02 INFO - 'TERM': 'linux', 21:57:02 INFO - 'TMOUT': '86400', 21:57:02 INFO - 'USER': 'cltbld', 21:57:02 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:02 INFO - '_': '/tools/buildbot/bin/python'} 21:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:02 INFO - Downloading/unpacking jsonschema 21:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:57:04 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 21:57:04 INFO - Downloading/unpacking functools32 (from jsonschema) 21:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:04 INFO - Downloading functools32-3.2.3-2.tar.gz 21:57:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:57:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:57:04 INFO - warning: no files found matching '*.txt' 21:57:04 INFO - no previously-included directories found matching 'build' 21:57:04 INFO - no previously-included directories found matching 'dist' 21:57:04 INFO - no previously-included directories found matching '.git*' 21:57:04 INFO - Installing collected packages: jsonschema, functools32 21:57:04 INFO - Running setup.py install for functools32 21:57:04 INFO - warning: no files found matching '*.txt' 21:57:04 INFO - no previously-included directories found matching 'build' 21:57:04 INFO - no previously-included directories found matching 'dist' 21:57:04 INFO - no previously-included directories found matching '.git*' 21:57:04 INFO - Successfully installed jsonschema functools32 21:57:04 INFO - Cleaning up... 21:57:04 INFO - Return code: 0 21:57:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19dfe7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a3630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, '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': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', '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 21:57:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:57:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:57:04 INFO - Using env: {'DISPLAY': ':0', 21:57:04 INFO - 'HOME': '/home/cltbld', 21:57:04 INFO - 'LANG': 'en_US.UTF-8', 21:57:04 INFO - 'LANGUAGE': 'en_US:en', 21:57:04 INFO - 'LOGNAME': 'cltbld', 21:57:04 INFO - 'MAIL': '/var/mail/cltbld', 21:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:04 INFO - 'MOZ_NO_REMOTE': '1', 21:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:04 INFO - 'NO_EM_RESTART': '1', 21:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:04 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:04 INFO - 'SHELL': '/bin/bash', 21:57:04 INFO - 'SHLVL': '1', 21:57:04 INFO - 'TERM': 'linux', 21:57:04 INFO - 'TMOUT': '86400', 21:57:04 INFO - 'USER': 'cltbld', 21:57:04 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:04 INFO - '_': '/tools/buildbot/bin/python'} 21:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:04 INFO - Downloading/unpacking flake8 21:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:57:06 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 21:57:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:57:06 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 21:57:06 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 21:57:06 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 21:57:06 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 21:57:06 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 21:57:06 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 21:57:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:57:06 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 21:57:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:57:06 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 21:57:06 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 21:57:06 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 21:57:06 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 21:57:06 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 21:57:06 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 21:57:07 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 21:57:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:57:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:57:07 INFO - no previously-included directories found matching 'docs/_build' 21:57:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:57:07 INFO - Running setup.py install for pep8 21:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:57:07 INFO - no previously-included directories found matching 'docs/_build' 21:57:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:57:07 INFO - Cleaning up... 21:57:07 INFO - Return code: 0 21:57:07 INFO - Running post-action listener: _resource_record_post_action 21:57:07 INFO - Running post-action listener: _start_resource_monitoring 21:57:07 INFO - Starting resource monitoring. 21:57:07 INFO - ##### 21:57:07 INFO - ##### Running install step. 21:57:07 INFO - ##### 21:57:07 INFO - Running pre-action listener: _resource_record_pre_action 21:57:07 INFO - Running main action method: install 21:57:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:07 INFO - Reading from file tmpfile_stdout 21:57:07 INFO - Detecting whether we're running mozinstall >=1.0... 21:57:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:57:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:57:07 INFO - Reading from file tmpfile_stdout 21:57:07 INFO - Output received: 21:57:07 INFO - Usage: mozinstall [options] installer 21:57:07 INFO - Options: 21:57:07 INFO - -h, --help show this help message and exit 21:57:07 INFO - -d DEST, --destination=DEST 21:57:07 INFO - Directory to install application into. [default: 21:57:07 INFO - "/builds/slave/test-pgo"] 21:57:07 INFO - --app=APP Application being installed. [default: firefox] 21:57:07 INFO - mkdir: /builds/slave/test-pgo/build/application 21:57:07 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'] 21:57:07 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 21:57:24 INFO - Reading from file tmpfile_stdout 21:57:24 INFO - Output received: 21:57:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:57:24 INFO - Running post-action listener: _resource_record_post_action 21:57:24 INFO - ##### 21:57:24 INFO - ##### Running run-tests step. 21:57:24 INFO - ##### 21:57:24 INFO - Running pre-action listener: _resource_record_pre_action 21:57:24 INFO - Running main action method: run_tests 21:57:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:57:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:57:24 INFO - Python 2.7.3 21:57:24 INFO - Return code: 0 21:57:24 INFO - grabbing minidump binary from tooltool 21:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:24 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 0x1534840>, '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 0x14a16b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14a1b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:57:24 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 21:57:24 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 21:57:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:57:24 INFO - Return code: 0 21:57:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:57:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:57:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:57:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:57:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:57:30 INFO - Return code: 0 21:57:30 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/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 21:57:30 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/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 21:57:30 INFO - Using env: {'DISPLAY': ':0', 21:57:30 INFO - 'HOME': '/home/cltbld', 21:57:30 INFO - 'LANG': 'en_US.UTF-8', 21:57:30 INFO - 'LANGUAGE': 'en_US:en', 21:57:30 INFO - 'LOGNAME': 'cltbld', 21:57:30 INFO - 'MAIL': '/var/mail/cltbld', 21:57:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:30 INFO - 'MOZ_NO_REMOTE': '1', 21:57:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:30 INFO - 'NO_EM_RESTART': '1', 21:57:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:30 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:57:30 INFO - 'SHELL': '/bin/bash', 21:57:30 INFO - 'SHLVL': '1', 21:57:30 INFO - 'TERM': 'linux', 21:57:30 INFO - 'TMOUT': '86400', 21:57:30 INFO - 'USER': 'cltbld', 21:57:30 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710', 21:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:30 INFO - '_': '/tools/buildbot/bin/python'} 21:57:30 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/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 21:57:30 INFO - mozversion application_buildid: 20151225193239 21:57:30 INFO - mozversion application_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 21:57:30 INFO - mozversion application_display_name: Nightly 21:57:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:57:30 INFO - mozversion application_name: Firefox 21:57:30 INFO - mozversion application_remotingname: firefox 21:57:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:57:30 INFO - mozversion application_vendor: Mozilla 21:57:30 INFO - mozversion application_version: 46.0a1 21:57:30 INFO - mozversion platform_buildid: 20151225193239 21:57:30 INFO - mozversion platform_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 21:57:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:57:30 INFO - mozversion platform_version: 46.0a1 21:57:30 INFO - using testdate: 1451109450 21:57:30 INFO - actual date: 1451109450 21:57:31 INFO - starting webserver on 'localhost:47752' 21:57:31 INFO - SUITE-START | Running 3 tests 21:57:31 INFO - TEST-START | dromaeo_css 21:57:31 INFO - operating with platform_type : linux_ 21:57:31 INFO - Initialising browser for dromaeo_css test... 21:57:31 INFO - TEST-INFO | started process 12980 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPz8MA6/profile http://localhost:47752/getInfo.html) 21:57:45 INFO - PROCESS | 12980 | __metrics Screen width/height:1600/1200 21:57:45 INFO - PROCESS | 12980 | colorDepth:24 21:57:45 INFO - PROCESS | 12980 | Browser inner width/height: 1024/697 21:57:45 INFO - PROCESS | 12980 | __metrics 21:57:46 INFO - PROCESS | 12980 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:57:46 INFO - PROCESS | 12980 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:57:50 INFO - TEST-INFO | 12980: exit 0 21:57:50 INFO - Browser initialized. 21:57:50 INFO - Running cycle 1/1 for dromaeo_css test... 21:57:50 INFO - TEST-INFO | started process 13074 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPz8MA6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:58:09 INFO - PROCESS | 13074 | RSS: Main: 150982656 21:58:09 INFO - PROCESS | 13074 | 21:58:55 INFO - PROCESS | 13074 | 1451109535904 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] 22:01:07 INFO - PROCESS | 13074 | Cycle 1(1): loaded http://localhost:47752/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47752/tests/dromaeo/cssquery-ext.html) 22:01:11 INFO - PROCESS | 13074 | RSS: Main: 251482112 22:01:11 INFO - PROCESS | 13074 | 22:04:13 INFO - PROCESS | 13074 | Cycle 1(1): loaded http://localhost:47752/tests/dromaeo/cssquery-ext.html (next: http://localhost:47752/tests/dromaeo/cssquery-jquery.html) 22:04:14 INFO - PROCESS | 13074 | RSS: Main: 227241984 22:04:14 INFO - PROCESS | 13074 | 22:07:16 INFO - PROCESS | 13074 | Cycle 1(1): loaded http://localhost:47752/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47752/tests/dromaeo/cssquery-mootools.html) 22:07:16 INFO - PROCESS | 13074 | RSS: Main: 224862208 22:07:16 INFO - PROCESS | 13074 | 22:10:18 INFO - PROCESS | 13074 | Cycle 1(1): loaded http://localhost:47752/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47752/tests/dromaeo/cssquery-prototype.html) 22:10:19 INFO - PROCESS | 13074 | RSS: Main: 218370048 22:10:19 INFO - PROCESS | 13074 | 22:13:21 INFO - PROCESS | 13074 | Cycle 1(1): loaded http://localhost:47752/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47752/tests/dromaeo/cssquery-yui.html) 22:13:22 INFO - PROCESS | 13074 | RSS: Main: 216723456 22:13:22 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | Cycle 1(1): loaded http://localhost:47752/tests/dromaeo/cssquery-yui.html (next: http://localhost:47752/tests/dromaeo/cssquery-dojo.html) 22:16:24 INFO - PROCESS | 13074 | RSS: Main: 261230592 22:16:24 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | __start_tp_report 22:16:24 INFO - PROCESS | 13074 | _x_x_mozilla_page_load 22:16:24 INFO - PROCESS | 13074 | _x_x_mozilla_page_load_details 22:16:24 INFO - PROCESS | 13074 | |i|pagename|runs| 22:16:24 INFO - PROCESS | 13074 | |0;dojo.html;3082.198628356627;3098.876044958202;3136.341368312653;3167.952480712789;3179.2846609512862;4963.503649635035;4984.900301993958;5015.147424937761;5025.321581586485;5028.0698070856915;4837.443693975194;5010.624203184767;5042.899142017158;5136.794528218867;5173.767180476878;4646.303054541829;4659.091477161955;4701.435827700664;4714.929276060861;4735.360726301957;4538.455385353745;4629.259318509039;4650.65120115991;4660.277656963159;4726.574608285254;4575.382323386333;4576.748278844662;4588.105319462689;4611.30830375443;4640.46634637016;4513.0296986147805;4542.38677778499;4566.429196350457;4578.793954272066;4610.608098311647;4524.705894116872;4552.499225085238;4586.839460618862;4606.838760643395;4685.461171965234;4944.381952255968;4950.455449900508;4958.057968985881;4981.452040275567;5025.974870125626;5425.267588875491;5426.457354264581;5435.1847222916485;5437.782488700447;5447.918281225785;5243.318368612056;5342.091844386464;5342.171963345688;5374.355077390738;5436.864078398072;5094.566961808251;5121.308623335802;5125.077486052472;5127.8205262816;5128.717920514333;5546.889062218733;5569.331680198321;5571.192177134293;5573.554115670737;5574.637648552831;5236.136037553837;5271.736413179326;5327.786888524415;5346.572274218053;5399.163129714901;5363.141897296414;5363.517283444508;5376.865578360494;5377.005254028018;5381.219723140122;5204.71374074422;5346.812861549827;5347.197920311906;5348.238860744374;5384.138537833927;5301.973490132525;5385.515303622615;5466.9179962300595;5478.150886612581;5532.5573954083575;4215.936760948588;4216.451861258017;4223.408722778813;4236.830526778956;4266.018815672351;3722.181120153562;3797.240551889578;3807.2956503047026;3816.0841398064263;3841.4237864320576;5104.948950510522;5146.253793199965;5146.356705411824;5146.356705411824;5195.922061169085;5425.430329815392;5427.104527752956;5441;5442.755076021588;5489.505944465017;5060.645754797202;5066.9746651266505;5100.642954993189;5112.437631860566;5149.098907691139;4744.905101897943;4758.95241047592;4761.500042495557;4768.499307572655;4802.951970480251;5649.0396632572565;5673.461021202979;5675.716214189357;5676.772929082873;5677.829665110054;5243.475652434726;5333.7866485340155;5339.492748188916;5438.15708565173;5457.863553411196;5637.774489020393;5640.379558248672;5644.717764111696;5647.463490968352;5653.067243904709;5352.5450336721815;5384.165454354581;5386.057439948072;5397.163439666858;5399.8788997747115;5245.134552798745;5363.704996225245;5435.728213589384;5487.396386397413;5527.861803454945;5323.334583177103;5331.893362132813;5332.733363331896;5335.573154147736;5339.866503337447;5305;5327.121025030827;5330.62685612019;5330.946690533045;5377.919331210113;5110.948890511196;5120.564751996122;5202.635815492879;5206.479352064764;5224.03355379256;5259.053370393366;5261.710605916712;5265.52610265078;5266.447023062523;5273.235380869829;5169.612279079009;5170.1986192140275;5179.8446046618665;5217.34783152106;5219.9217011744095 22:16:24 INFO - PROCESS | 13074 | |1;ext.html;576.8125359258241;600.486583970705;606.390577469643;606.4420732925713;620.8168590265873;28464.00375986841;29407.852960735192;36468.63531364689;36927;37142.8142859286;39451;40044.59955400445;40049.39925901114;40051.19897602046;40110.39834402479;7360.300771426706;8250.752477425656;8505.489670619752;8514.148585141498;8520.914790852104;7245.818854528627;7740.961295193544;10144.289899707024;10302.742431439237;10326.896731032668;10030.147437467787;10165;10210.38737675738;10212.029857163558;10213.438260895648;7541.660625271876;9969.252306077036;10057.949710251474;10074.949625251827;10091.949540252324;7458;10071.395716257048;10272.948635256851;10287.12559432449;10288.74278143045;36727;37142.44286335707;37153;37201.627983720085;37210;3201.9199520011953;3209.9197520061953;3236.91907702307;3246.123546642393;3254.8698052078125;28365.432691346057;28574.142775716762;28664.856675716488;29435.264118396997;30909.690903090905;3839.155385815116;3915.3735402335487;3921.647051765326;4001.479807625019;4030.5163380394542;258869;261221;261393.9999999981;261462.69268653725;262014;51096;51936.48063519392;59384;59654.403455964886;60230.69884650636;58575.121373179434;58873.70563147157;58900;58955.70522147362;59219.407805921386;15865.20673966297;15999.520014399586;16012.599685007968;16014.519564413085;16025.19874006295;11668.299902005907;11845.289282643069;11879.643610691694;11879.643610691694;11981.700457488458;19257.32599359044;19275.325363612206;19544.631875768842;19623.116959736846;19632.509187270432;6789.592624442549;7303.342699157101;7360.190379058299;7364.600725862069;7421.332080112816;962.5331714118647;1005.1807776661997;1012.8632634594383;1029.6653587583914;1132.4790596325618;28276.293092672848;31058;31262;31271.374572508423;31498;982.5480279071564;1006.8691070160833;1063.532325390971;1114.5820317380983;1152.4065106470175;15203.543893683207;15635.921820390826;15742.449014284444;15791.131487768283;15914.60213494672;329529;329982;330887;331654;332141;52835.735821320646;53073;53087.73456132694;53178.46821531735;53183;1237.975240495185;1246.7070238493948;1277.1379318959664;1338.6118025772416;1359.7756370198806;25922.22233333003;26255.606165907146;26457.735422645528;26706;26854.328641784112;39710;39973.20053598854;40089.59910400859;40132.59867401289;40163.1967360657;294788;299864;312421;316793;316889;28734.712652873204;28806.703698334044;28820.711792881804;28826.42347153087;28853.85573072121;38321.23357532889;39700.602993970846;39911.800440997606;40104.197916042096;40404;36536.08659783527;36594.26811463809;36741.44887826631;37979.810100950424;38174.23651526898;36228.63771362358;37000.81499592485;37378.6262137386;37761.65740939717;37917.43123853199;35734.4639830408;36210.8189459051;36376.81811590925;36473.635263647026;36842.44736328904;32316.515252270765;33220.33559328751;33481.33037339191;33564;33808.32383352368;25161;25269.87365063163;25385.365365866;25650.358741031625;26118.608220877082 22:16:24 INFO - PROCESS | 13074 | |2;jquery.html;361.55348145040887;363.30427231851;363.50926249563094;366.0446235325801;366.43203035295295;14063.789043164335;14112.294385280746;16073;17354.56613584661;18395.81604183958;14357.856421435783;14391.136531808099;14427.990040697156;14831.258437078157;14836.703265934702;5202.635815492917;5315.388730296027;5327.760250788704;5328.600354973373;5332.68003919766;4010.1979604079156;4133.958660413387;5284.365876094855;5344.599155063366;5741.770329186827;5830;5846.269216347957;5846.561507886904;5860.208871802295;5871.618344807595;5712.6286791358425;5830.912536311958;5870.999999999979;5876.147958546029;5883.058710606325;5199.428062913076;5203.869903252411;5205.27126202332;5213.478652134794;5220.556252718524;19384.515387115294;20305;20381;20400.897995510077;20917.790822091738;2109.841761867866;2248.4716091718433;2271.5570463759573;2406.7713567211085;2489.3154382544762;12947.935260323733;13227.801582976263;13241.602751917362;13554.86445135546;13623.18260904349;1805.1515787579947;1822.4168266154836;1828.7988321284647;1839.8868684445852;1843.483824529134;57532.13701794476;59501.7024914877;60099;60660.966951652685;60915.39084609142;9723.270754693427;10048.899511004942;10050.74873128163;10052.497375131361;10118;13211.801822972662;13274.20798192251;13291.534796282083;13309.866901331057;13313.40089695966;7630.542167469969;7688.0005599271735;7722.961385193151;7758.806029849299;7812.492188007761;7522.924770752332;7535.886961695579;7575.166731659513;7586.734464293833;7598.658060387296;5896.528277737771;5974.372690867396;5992.64044157352;5995.190649262381;6035.336113027563;1652.6942515634646;1707.795064592232;1716.2963185094052;1741.5820203151407;1802.9368972085913;933.8459154239474;948.9240860731124;1023.0690072034562;1045.3100953370738;1101.0896095274693;14606.269686515632;16185.919070404809;17058.402955896483;17444;17764.378246761302;915.3729695158837;964.6527250189926;978.9804203916025;1010.4796030044533;1044.8223801953686;9487.430754154773;9705.223582113415;9999;10021.448820314952;10064.74838129038;471056;477709;477859;491039;501859;77240;78264.82602760963;80402.95970402913;81022.18977810147;82981.58509207415;1192.7674103549898;1193.7612477504533;1212.2605210821391;1217.7868872947377;1230.2311055590255;15563.37746490173;15639.374425022872;15724.606884827514;15926.761098583762;15941.44204952821;33780.83109584436;34065.14837129092;34526.48210276898;34658;34674.306513870084;44614.3307850389;45000.77499612481;45014.77492612516;45313;48813.51186488089;9685.564149613143;9821.459819709698;9834.803303934024;9908.157806586521;9929.007099290013;12033.75932481328;16716.749248761036;17380.04409757425;17444.825551744827;17551.122443878012;13832.515861944783;14005.929970350084;14040.1575905446;14363.066400683922;14414.13515189092;13712.725745485233;14227;14439.2058436787;14462.349194286073;14491.275436228358;11549.538018479503;12199;14305.21321327337;14387.712245754818;14814.40742370293;9597.520123993912;9601.903980960102;9695.51522423862;9739.513024348897;9771;3001.5647731078434;11960;13670.794938076137;13706.931465343008;14618.561443156723 22:16:24 INFO - PROCESS | 13074 | |3;mootools.html;1328.8671132886707;1437.6405898525368;1446.3636000159925;1584.6592982508766;1767.9933275732049;6476.967615161923;7154.928450715492;7254.528455650379;7263.0194923685285;7271.709131634741;6859.554128981613;6982.965085174567;6991.510594258404;6994.860102797941;7003.509754317187;2163.9891800540977;2199.120351859261;2202.1631779923605;2202.526456811785;2206.415299945516;2190.5071358944188;2205.52581195043;2293.86236825791;2305.965410518844;2308.53829234153;2233.106757297078;2238.910443582263;2252.538229662915;2271;2287.9885600571974;2082.1879467007802;2101.5271563898154;2119.6290649136495;2120.9257675981344;2123.2462475821094;2244.9214277500373;2281.783230593091;2284.3603790938564;2285.645724912641;2292;7185.928140718631;7262.600556969364;7278.053852999129;7282.271772822728;7310.4517161213125;4300.677449191292;4375.518692943773;4377.934330985037;4407.0524837160165;4413.470383553962;3022.8337441440713;3060.066679662702;3062.5406189071596;3068.6777888321853;3091.2890035291784;970.1801977329145;979.750163708257;980.2990861533966;997.5361456922493;1012.8126296635072;9787.706368808947;9803.068708472754;9805.264605154642;9834.9508252459;9848.852267215998;4037.253108174997;4054.878353649395;4079.3676980068135;4103;4113.239050775616;8393.454425462325;8393.832123357499;8398.538080405637;8402.537860417613;8410.411271210956;4387.166438376698;4418.425604671436;4425.579569940851;4428;4429.158459892675;3652.8538858445363;3726.757760745543;4010.19796040793;4012.3179059559943;4093.099518106012;3398.218409765718;3402.591688997336;3418.1283772637817;3433.364827506919;3439.2949445363643;1128.08061429936;1134.8184290513477;1136.6590022993234;1141.6289705845634;1142.4744617475887;1292.7479141567303;1293.32100647161;1311.4360824845216;1317.0517227596115;1317.808917706927;6856.417204537571;6910.06714093601;6939.063226464464;6947.965260173768;6964.547304425196;462.94213223347083;473.73234122720555;474.7673639916485;478.9784459699322;479.94480634726756;5474.370447398521;5478.506934375925;5497.45025497447;5522.696251706195;5533.22534845122;8639.265662418766;8667.4366166199;8863.2466240369;8971.05803890595;8973.820523589491;8772.517511536798;8877.556122193864;8894.59974301158;8924.286057115416;8942.552872356357;6875.07186529812;6978.860422791618;6984;6992.091028166407;7000.124984376953;6764.797056088325;6780.491463140383;6785.796426107225;6788.287229840796;6796.830079248059;7707.344875685405;7927.60361981887;7934.087579928382;8048.83902321962;8052.315553178046;8002.479838810692;8159.632816523389;8171.918280817115;8272.296854767412;8292.958535207285;6591.802245932629;6647.9002814958785;6693.464522838064;6695.598264104169;6701.128853249046;7182.712691492491;7206.063211782434;7239.927600723925;7240.05879235696;7281.817954551178;6546.116274302908;6771.119754431892;6834.419074378733;6841.213260475109;6952.304769523007;6710.765123220859;6761.628110453972;6775.186977562724;6839.589624622538;6853.760118395832;6376.234851817811;6431;6481.578697384655;6499.772507962199;6507;5833.183354330312;5863.618864773776;5873.853153671193;5880.735366908414;5883.499902508334;6017.669028203491;6057.515398768;6064.909026364519;6068.817935461943;6072.90890636632 22:16:24 INFO - PROCESS | 13074 | |4;prototype.html;342.8971308607417;348.2634228606498;349.58574089703694;352.4185094593921;357.2159110751899;5892.351841297454;5986.341502434729;6041.093835924614;6051.576389652726;6054.8789024219595;5746.885062298762;5839;5875.911861322073;5938.40615938406;5946.672932988684;4635.83774567891;4655.837045703401;4658.464276608182;4658.86023419298;4660.603848672867;4418.050119224366;4495.258282383403;4499.482559505666;4655.394798676168;4658.720476771387;4598.563136502027;4611.423572053493;4626.329182268569;4635.443746750395;4635.930461043087;4606.97696511517;4612.031473390592;4618.076384723069;4619.63042956566;4620.838270660511;4096.32410652242;4099.672026237924;4103.4050062740735;4103.630673239393;4109.849242212185;5558.44415558445;5677.205191273225;5689.857753556194;5690.772369105231;5697.03150464422;5400.432954539795;5408.2428460015235;5408.432114627986;5412.91880621791;5417.945820541823;6349.047642853563;6349.174607301067;6351.809445716636;6357.300696923335;6358.936410635881;4344.391785150082;4414.205443020255;4433.490148632916;4510.909781804346;4516.322551617251;6569.0474881142445;6602.768903088417;6629.535932484728;6632.104665870094;6638.302978187317;4670.252759558454;4679.532046795293;4680.602148817388;4682;4683.157031734252;4613.7312239133835;4720.95279047212;4742.478327383985;4745.549172828576;4747.738874361874;5353.705546194997;5384.6499977501335;5386.649867758583;5390.622656414092;5391.433899440581;6402.775902843378;6406.871862562816;6408.903866442007;6410.61536307823;6411.551191416556;1663.1767275198854;1683.9158042097847;1686.047383228472;1687.2829047654698;1688.8226736192523;1142.2118738070706;1145.5818626201376;1147.8565179352581;1152.458344578047;1167.9824802627968;6064.241969753781;6073.969630151821;6080;6084.908726369108;6095.359987201368;6529.902051469232;6568.376004279586;6577.375149360803;6583.670816459158;6585.703643336062;5965.821025369246;6048.0625503047095;6085.786997455068;6092.116643086816;6103.084537319438;3552.7335449841366;3576.1774791798034;3579.6957258632788;3581.426971684518;3583.086312990171;6760.628165450948;6835.043093966849;6838;6842.247352791189;6845.657717114124;6699.062131301622;6713.12729345182;6717.328267173243;6732.596044237362;6738.191417029988;6718.596884186964;6812.318768123148;6852.109225800714;6861.794146175623;6862.588244705234;6385.553011289351;6630.966845165936;6640.867182656417;6648.936170212743;6659.367360100783;6378.266499352634;6479.676016199265;6497.4477169441125;6500.772472963424;6502.707378168088;6843.3840954314355;6854.417374523022;6860.3139686031;6912.896306555305;6915.101036865175;4535.591796738177;4567.429071366079;4569.423548875632;4573.245414506569;4576.702514336557;6444.516661250331;6573.474122070318;6589.736410543716;6593.208814942046;6600.966995164993;6410.647414392067;6425.10048593188;6452.483801295979;6491.318411566906;6493.480521558358;6200.658963757037;6454;6475.449586785176;6477.093206950936;6477.995910633671;6293;6296.559240853279;6302.527310451643;6307.148534947723;6318.557700960889;6493.2857385688485;6496.805095847132;6497.8700425992165;6500.869982600227;6510.837229069311;6223.657698826427;6359.491240700825;6362.109304697254;6363.268224154096;6365.427111559982 22:16:24 INFO - PROCESS | 13074 | |5;yui.html;768.0821418405009;777.2072486064211;792.0086328940985;800.691733682532;844.7719115838723;12786.232826030433;12997.155184912974;13005.479780808768;13006;13020.34898255087;12692;12780.424880880359;12939.870601293984;13419.597412077628;13452;681.264234626602;701.6281370873445;820.5733018830205;833.6957010691115;833.9791505212388;814.2549567146084;840.684743221292;847.5719761520423;847.9745607631781;848.3637272045966;862.5514732339179;869.6434461870634;870.0951010948637;871.9869201961976;873.135595760196;713.2439614009141;735.2500449541465;859.8968123825118;865.1002956924791;879.7712594725417;643.8486955565485;644.1046944746805;645.0646562484417;648.1962366665301;649.0523835200613;12556.81164782529;12616.369181540886;12643.178193417398;12721.681957951032;12763.87236127636;10598.523066462029;11410.54357825686;11420.828687569694;11465.426728663617;11972.64082077539;10054.296199266055;10338.276320657556;10583.84124238137;10588.417637029961;10824.350538967608;3403;3442.345954268706;3448.827558622059;3454.5336379588935;3525.806080665562;46968.76515617434;46996.53003469956;47089.29366059512;47399.526004740204;47426.76286618545;7764.107127680389;8024.79938001543;8044.316233120133;8119.431639785158;8340.874886876702;16047.598810029842;16115.919420402823;16141.35434582627;16171.757423638655;16182;7616.200298968639;7706.113796913314;7762.486776953911;7849.843003140019;8007.279344858991;4222.725522841006;4254.532001479834;4313.158934007838;4315.503717072514;4383.7588932609015;3061.4336347775734;3114.828684422333;3117.173948903542;3120.4851199551817;3121.2977080156784;579.5537436174122;583.5777271131175;588.7380115848406;589.9292084949833;598.2701104652317;611.929628092775;617.6201635993831;628.5725706519611;643.9742410303535;646.809191288571;7847.097583777939;8050.4364694472;8058.194180582012;8068.8386232275025;8249.29880960125;551.8923809857039;631.3844002098009;640.545212898847;652.8922727749868;653.9378759017885;3646.5988741238443;3809.542854857435;3846.288436639231;3869.7097717671286;3940;55377.16934245989;57397.71301143467;57522;57550.7122464385;57703.4229657698;48526;50067;50463.747681262095;50617;51408.74295628498;44737.776311118236;44996.55003449989;45374.773126134816;46269;46664.7666761664;8012.238837310446;8083.636236369495;8177.6320065596;8202.179782021989;8320.126386729306;35384.11539711528;35941.28117437584;36269.0932726684;36644.26711465809;36733.63266367302;42112.78943605385;42354.576454235066;45114.77442612766;45373.54626453693;46357;9611.903880961101;10049.447280399649;10084.425903853911;10338.948305258426;10652.09457196147;11348.886511134782;11467.4266286687;11908.486702472092;12871.554404663084;12983.091183617056;10667.94618045138;10752.784944301227;10889.401082940514;10988.615398461336;11385.259958102697;11740.354280514654;12102.092343074128;12123;12296;12616.17994830333;10496.580136794748;10794.19043571751;10893.07408870255;11151.498182581965;11248.437578120898;9083.591238394156;9298.535073246447;9307;9317.86023209666;9833.950830245803;8807.559622019002;9022.413543119676;9194.49430281341;9513.476758778057;9727.811242470387 22:16:24 INFO - PROCESS | 13074 | __end_tp_report 22:16:24 INFO - PROCESS | 13074 | __start_cc_report 22:16:24 INFO - PROCESS | 13074 | _x_x_mozilla_cycle_collect,818 22:16:24 INFO - PROCESS | 13074 | __end_cc_report 22:16:24 INFO - PROCESS | 13074 | __startTimestamp1451110584871__endTimestamp 22:16:24 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | ------- Summary: start ------- 22:16:24 INFO - PROCESS | 13074 | Number of tests: 6 22:16:24 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | [#0] dojo.html Cycles:165 Average:5042.64 Median:5206.48 stddev:535.74 (10.3%) stddev-sans-first:514.84 22:16:24 INFO - PROCESS | 13074 | Values: 3082.2 3098.9 3136.3 3168.0 3179.3 4963.5 4984.9 5015.1 5025.3 5028.1 4837.4 5010.6 5042.9 5136.8 5173.8 4646.3 4659.1 4701.4 4714.9 4735.4 4538.5 4629.3 4650.7 4660.3 4726.6 4575.4 4576.7 4588.1 4611.3 4640.5 4513.0 4542.4 4566.4 4578.8 4610.6 4524.7 4552.5 4586.8 4606.8 4685.5 4944.4 4950.5 4958.1 4981.5 5026.0 5425.3 5426.5 5435.2 5437.8 5447.9 5243.3 5342.1 5342.2 5374.4 5436.9 5094.6 5121.3 5125.1 5127.8 5128.7 5546.9 5569.3 5571.2 5573.6 5574.6 5236.1 5271.7 5327.8 5346.6 5399.2 5363.1 5363.5 5376.9 5377.0 5381.2 5204.7 5346.8 5347.2 5348.2 5384.1 5302.0 5385.5 5466.9 5478.2 5532.6 4215.9 4216.5 4223.4 4236.8 4266.0 3722.2 3797.2 3807.3 3816.1 3841.4 5104.9 5146.3 5146.4 5146.4 5195.9 5425.4 5427.1 5441.0 5442.8 5489.5 5060.6 5067.0 5100.6 5112.4 5149.1 4744.9 4759.0 4761.5 4768.5 4803.0 5649.0 5673.5 5675.7 5676.8 5677.8 5243.5 5333.8 5339.5 5438.2 5457.9 5637.8 5640.4 5644.7 5647.5 5653.1 5352.5 5384.2 5386.1 5397.2 5399.9 5245.1 5363.7 5435.7 5487.4 5527.9 5323.3 5331.9 5332.7 5335.6 5339.9 5305.0 5327.1 5330.6 5330.9 5377.9 5110.9 5120.6 5202.6 5206.5 5224.0 5259.1 5261.7 5265.5 5266.4 5273.2 5169.6 5170.2 5179.8 5217.3 5219.9 22:16:24 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | [#1] ext.html Cycles:180 Average:46435.08 Median:166391.93 stddev:78835.95 (47.4%) stddev-sans-first:78981.91 22:16:24 INFO - PROCESS | 13074 | Values: 576.8 600.5 606.4 606.4 620.8 28464.0 29407.9 36468.6 36927.0 37142.8 39451.0 40044.6 40049.4 40051.2 40110.4 7360.3 8250.8 8505.5 8514.1 8520.9 7245.8 7741.0 10144.3 10302.7 10326.9 10030.1 10165.0 10210.4 10212.0 10213.4 7541.7 9969.3 10057.9 10074.9 10091.9 7458.0 10071.4 10272.9 10287.1 10288.7 36727.0 37142.4 37153.0 37201.6 37210.0 3201.9 3209.9 3236.9 3246.1 3254.9 28365.4 28574.1 28664.9 29435.3 30909.7 3839.2 3915.4 3921.6 4001.5 4030.5 258869.0 261221.0 261394.0 261462.7 262014.0 51096.0 51936.5 59384.0 59654.4 60230.7 58575.1 58873.7 58900.0 58955.7 59219.4 15865.2 15999.5 16012.6 16014.5 16025.2 11668.3 11845.3 11879.6 11879.6 11981.7 19257.3 19275.3 19544.6 19623.1 19632.5 6789.6 7303.3 7360.2 7364.6 7421.3 962.5 1005.2 1012.9 1029.7 1132.5 28276.3 31058.0 31262.0 31271.4 31498.0 982.5 1006.9 1063.5 1114.6 1152.4 15203.5 15635.9 15742.4 15791.1 15914.6 329529.0 329982.0 330887.0 331654.0 332141.0 52835.7 53073.0 53087.7 53178.5 53183.0 1238.0 1246.7 1277.1 1338.6 1359.8 25922.2 26255.6 26457.7 26706.0 26854.3 39710.0 39973.2 40089.6 40132.6 40163.2 294788.0 299864.0 312421.0 316793.0 316889.0 28734.7 28806.7 28820.7 28826.4 28853.9 38321.2 39700.6 39911.8 40104.2 40404.0 36536.1 36594.3 36741.4 37979.8 38174.2 36228.6 37000.8 37378.6 37761.7 37917.4 35734.5 36210.8 36376.8 36473.6 36842.4 32316.5 33220.3 33481.3 33564.0 33808.3 25161.0 25269.9 25385.4 25650.4 26118.6 22:16:24 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | [#2] jquery.html Cycles:180 Average:27226.74 Median:18391.20 stddev:79156.50 (430.4%) stddev-sans-first:79352.85 22:16:24 INFO - PROCESS | 13074 | Values: 361.6 363.3 363.5 366.0 366.4 14063.8 14112.3 16073.0 17354.6 18395.8 14357.9 14391.1 14428.0 14831.3 14836.7 5202.6 5315.4 5327.8 5328.6 5332.7 4010.2 4134.0 5284.4 5344.6 5741.8 5830.0 5846.3 5846.6 5860.2 5871.6 5712.6 5830.9 5871.0 5876.1 5883.1 5199.4 5203.9 5205.3 5213.5 5220.6 19384.5 20305.0 20381.0 20400.9 20917.8 2109.8 2248.5 2271.6 2406.8 2489.3 12947.9 13227.8 13241.6 13554.9 13623.2 1805.2 1822.4 1828.8 1839.9 1843.5 57532.1 59501.7 60099.0 60661.0 60915.4 9723.3 10048.9 10050.7 10052.5 10118.0 13211.8 13274.2 13291.5 13309.9 13313.4 7630.5 7688.0 7723.0 7758.8 7812.5 7522.9 7535.9 7575.2 7586.7 7598.7 5896.5 5974.4 5992.6 5995.2 6035.3 1652.7 1707.8 1716.3 1741.6 1802.9 933.8 948.9 1023.1 1045.3 1101.1 14606.3 16185.9 17058.4 17444.0 17764.4 915.4 964.7 979.0 1010.5 1044.8 9487.4 9705.2 9999.0 10021.4 10064.7 471056.0 477709.0 477859.0 491039.0 501859.0 77240.0 78264.8 80403.0 81022.2 82981.6 1192.8 1193.8 1212.3 1217.8 1230.2 15563.4 15639.4 15724.6 15926.8 15941.4 33780.8 34065.1 34526.5 34658.0 34674.3 44614.3 45000.8 45014.8 45313.0 48813.5 9685.6 9821.5 9834.8 9908.2 9929.0 12033.8 16716.7 17380.0 17444.8 17551.1 13832.5 14005.9 14040.2 14363.1 14414.1 13712.7 14227.0 14439.2 14462.3 14491.3 11549.5 12199.0 14305.2 14387.7 14814.4 9597.5 9601.9 9695.5 9739.5 9771.0 3001.6 11960.0 13670.8 13706.9 14618.6 22:16:24 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | [#3] mootools.html Cycles:180 Average:5142.95 Median:6224.57 stddev:2643.45 (42.5%) stddev-sans-first:2635.32 22:16:24 INFO - PROCESS | 13074 | Values: 1328.9 1437.6 1446.4 1584.7 1768.0 6477.0 7154.9 7254.5 7263.0 7271.7 6859.6 6983.0 6991.5 6994.9 7003.5 2164.0 2199.1 2202.2 2202.5 2206.4 2190.5 2205.5 2293.9 2306.0 2308.5 2233.1 2238.9 2252.5 2271.0 2288.0 2082.2 2101.5 2119.6 2120.9 2123.2 2244.9 2281.8 2284.4 2285.6 2292.0 7185.9 7262.6 7278.1 7282.3 7310.5 4300.7 4375.5 4377.9 4407.1 4413.5 3022.8 3060.1 3062.5 3068.7 3091.3 970.2 979.8 980.3 997.5 1012.8 9787.7 9803.1 9805.3 9835.0 9848.9 4037.3 4054.9 4079.4 4103.0 4113.2 8393.5 8393.8 8398.5 8402.5 8410.4 4387.2 4418.4 4425.6 4428.0 4429.2 3652.9 3726.8 4010.2 4012.3 4093.1 3398.2 3402.6 3418.1 3433.4 3439.3 1128.1 1134.8 1136.7 1141.6 1142.5 1292.7 1293.3 1311.4 1317.1 1317.8 6856.4 6910.1 6939.1 6948.0 6964.5 462.9 473.7 474.8 479.0 479.9 5474.4 5478.5 5497.5 5522.7 5533.2 8639.3 8667.4 8863.2 8971.1 8973.8 8772.5 8877.6 8894.6 8924.3 8942.6 6875.1 6978.9 6984.0 6992.1 7000.1 6764.8 6780.5 6785.8 6788.3 6796.8 7707.3 7927.6 7934.1 8048.8 8052.3 8002.5 8159.6 8171.9 8272.3 8293.0 6591.8 6647.9 6693.5 6695.6 6701.1 7182.7 7206.1 7239.9 7240.1 7281.8 6546.1 6771.1 6834.4 6841.2 6952.3 6710.8 6761.6 6775.2 6839.6 6853.8 6376.2 6431.0 6481.6 6499.8 6507.0 5833.2 5863.6 5873.9 5880.7 5883.5 6017.7 6057.5 6064.9 6068.8 6072.9 22:16:24 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | [#4] prototype.html Cycles:180 Average:5360.78 Median:6053.23 stddev:1592.39 (26.3%) stddev-sans-first:1551.67 22:16:24 INFO - PROCESS | 13074 | Values: 342.9 348.3 349.6 352.4 357.2 5892.4 5986.3 6041.1 6051.6 6054.9 5746.9 5839.0 5875.9 5938.4 5946.7 4635.8 4655.8 4658.5 4658.9 4660.6 4418.1 4495.3 4499.5 4655.4 4658.7 4598.6 4611.4 4626.3 4635.4 4635.9 4607.0 4612.0 4618.1 4619.6 4620.8 4096.3 4099.7 4103.4 4103.6 4109.8 5558.4 5677.2 5689.9 5690.8 5697.0 5400.4 5408.2 5408.4 5412.9 5417.9 6349.0 6349.2 6351.8 6357.3 6358.9 4344.4 4414.2 4433.5 4510.9 4516.3 6569.0 6602.8 6629.5 6632.1 6638.3 4670.3 4679.5 4680.6 4682.0 4683.2 4613.7 4721.0 4742.5 4745.5 4747.7 5353.7 5384.6 5386.6 5390.6 5391.4 6402.8 6406.9 6408.9 6410.6 6411.6 1663.2 1683.9 1686.0 1687.3 1688.8 1142.2 1145.6 1147.9 1152.5 1168.0 6064.2 6074.0 6080.0 6084.9 6095.4 6529.9 6568.4 6577.4 6583.7 6585.7 5965.8 6048.1 6085.8 6092.1 6103.1 3552.7 3576.2 3579.7 3581.4 3583.1 6760.6 6835.0 6838.0 6842.2 6845.7 6699.1 6713.1 6717.3 6732.6 6738.2 6718.6 6812.3 6852.1 6861.8 6862.6 6385.6 6631.0 6640.9 6648.9 6659.4 6378.3 6479.7 6497.4 6500.8 6502.7 6843.4 6854.4 6860.3 6912.9 6915.1 4535.6 4567.4 4569.4 4573.2 4576.7 6444.5 6573.5 6589.7 6593.2 6601.0 6410.6 6425.1 6452.5 6491.3 6493.5 6200.7 6454.0 6475.4 6477.1 6478.0 6293.0 6296.6 6302.5 6307.1 6318.6 6493.3 6496.8 6497.9 6500.9 6510.8 6223.7 6359.5 6362.1 6363.3 6365.4 22:16:24 INFO - PROCESS | 13074 | 22:16:24 INFO - PROCESS | 13074 | [#5] yui.html Cycles:180 Average:13485.26 Median:47042.91 stddev:15805.57 (33.6%) stddev-sans-first:15821.05 22:16:24 INFO - PROCESS | 13074 | Values: 768.1 777.2 792.0 800.7 844.8 12786.2 12997.2 13005.5 13006.0 13020.3 12692.0 12780.4 12939.9 13419.6 13452.0 681.3 701.6 820.6 833.7 834.0 814.3 840.7 847.6 848.0 848.4 862.6 869.6 870.1 872.0 873.1 713.2 735.3 859.9 865.1 879.8 643.8 644.1 645.1 648.2 649.1 12556.8 12616.4 12643.2 12721.7 12763.9 10598.5 11410.5 11420.8 11465.4 11972.6 10054.3 10338.3 10583.8 10588.4 10824.4 3403.0 3442.3 3448.8 3454.5 3525.8 46968.8 46996.5 47089.3 47399.5 47426.8 7764.1 8024.8 8044.3 8119.4 8340.9 16047.6 16115.9 16141.4 16171.8 16182.0 7616.2 7706.1 7762.5 7849.8 8007.3 4222.7 4254.5 4313.2 4315.5 4383.8 3061.4 3114.8 3117.2 3120.5 3121.3 579.6 583.6 588.7 589.9 598.3 611.9 617.6 628.6 644.0 646.8 7847.1 8050.4 8058.2 8068.8 8249.3 551.9 631.4 640.5 652.9 653.9 3646.6 3809.5 3846.3 3869.7 3940.0 55377.2 57397.7 57522.0 57550.7 57703.4 48526.0 50067.0 50463.7 50617.0 51408.7 44737.8 44996.6 45374.8 46269.0 46664.8 8012.2 8083.6 8177.6 8202.2 8320.1 35384.1 35941.3 36269.1 36644.3 36733.6 42112.8 42354.6 45114.8 45373.5 46357.0 9611.9 10049.4 10084.4 10338.9 10652.1 11348.9 11467.4 11908.5 12871.6 12983.1 10667.9 10752.8 10889.4 10988.6 11385.3 11740.4 12102.1 12123.0 12296.0 12616.2 10496.6 10794.2 10893.1 11151.5 11248.4 9083.6 9298.5 9307.0 9317.9 9834.0 8807.6 9022.4 9194.5 9513.5 9727.8 22:16:24 INFO - PROCESS | 13074 | -------- Summary: end -------- 22:16:24 INFO - PROCESS | 13074 | 22:16:26 INFO - TEST-INFO | 13074: exit 0 22:16:26 INFO - TEST-OK | dromaeo_css | took 1135396ms 22:16:26 INFO - TEST-START | kraken 22:16:26 INFO - operating with platform_type : linux_ 22:16:26 INFO - Initialising browser for kraken test... 22:16:26 INFO - TEST-INFO | started process 13271 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpagyPWN/profile http://localhost:47752/getInfo.html) 22:16:38 INFO - PROCESS | 13271 | __metrics Screen width/height:1600/1200 22:16:38 INFO - PROCESS | 13271 | colorDepth:24 22:16:38 INFO - PROCESS | 13271 | Browser inner width/height: 1024/697 22:16:38 INFO - PROCESS | 13271 | __metrics 22:16:38 INFO - PROCESS | 13271 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:16:39 INFO - PROCESS | 13271 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:16:43 INFO - TEST-INFO | 13271: exit 0 22:16:43 INFO - Browser initialized. 22:16:43 INFO - Running cycle 1/1 for kraken test... 22:16:43 INFO - TEST-INFO | started process 13350 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpagyPWN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:16:55 INFO - PROCESS | 13350 | RSS: Main: 148910080 22:16:55 INFO - PROCESS | 13350 | 22:16:57 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47752/tests/kraken/driver.html?testName=audio-beat-detection) 22:16:58 INFO - PROCESS | 13350 | RSS: Main: 187080704 22:16:58 INFO - PROCESS | 13350 | 22:17:00 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47752/tests/kraken/driver.html?testName=audio-dft) 22:17:01 INFO - PROCESS | 13350 | RSS: Main: 176214016 22:17:01 INFO - PROCESS | 13350 | 22:17:04 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47752/tests/kraken/driver.html?testName=audio-fft) 22:17:04 INFO - PROCESS | 13350 | RSS: Main: 159154176 22:17:04 INFO - PROCESS | 13350 | 22:17:06 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47752/tests/kraken/driver.html?testName=audio-oscillator) 22:17:07 INFO - PROCESS | 13350 | RSS: Main: 163446784 22:17:07 INFO - PROCESS | 13350 | 22:17:09 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47752/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:17:10 INFO - PROCESS | 13350 | RSS: Main: 165265408 22:17:10 INFO - PROCESS | 13350 | 22:17:12 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47752/tests/kraken/driver.html?testName=imaging-darkroom) 22:17:13 INFO - PROCESS | 13350 | RSS: Main: 164831232 22:17:13 INFO - PROCESS | 13350 | 22:17:17 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47752/tests/kraken/driver.html?testName=imaging-desaturate) 22:17:17 INFO - PROCESS | 13350 | RSS: Main: 162312192 22:17:17 INFO - PROCESS | 13350 | 22:17:20 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47752/tests/kraken/driver.html?testName=json-parse-financial) 22:17:21 INFO - PROCESS | 13350 | RSS: Main: 164802560 22:17:21 INFO - PROCESS | 13350 | 22:17:22 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47752/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:17:23 INFO - PROCESS | 13350 | RSS: Main: 176799744 22:17:23 INFO - PROCESS | 13350 | 22:17:24 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47752/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:17:25 INFO - PROCESS | 13350 | RSS: Main: 175431680 22:17:25 INFO - PROCESS | 13350 | 22:17:27 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47752/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:17:28 INFO - PROCESS | 13350 | RSS: Main: 184102912 22:17:28 INFO - PROCESS | 13350 | 22:17:30 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47752/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:17:31 INFO - PROCESS | 13350 | RSS: Main: 190312448 22:17:31 INFO - PROCESS | 13350 | 22:17:33 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47752/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:17:34 INFO - PROCESS | 13350 | RSS: Main: 189239296 22:17:34 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | Cycle 1(1): loaded http://localhost:47752/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47752/tests/kraken/driver.html?testName=ai-astar) 22:17:36 INFO - PROCESS | 13350 | RSS: Main: 247537664 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | __start_tp_report 22:17:36 INFO - PROCESS | 13350 | _x_x_mozilla_page_load 22:17:36 INFO - PROCESS | 13350 | _x_x_mozilla_page_load_details 22:17:36 INFO - PROCESS | 13350 | |i|pagename|runs| 22:17:36 INFO - PROCESS | 13350 | |0;ai-astar;110;113;108;110;111;110;100;109;109;109 22:17:36 INFO - PROCESS | 13350 | |1;audio-beat-detection;154;130;145;168;122;162;150;128;163;127 22:17:36 INFO - PROCESS | 13350 | |2;audio-dft;160;160;160;160;160;160;157;161;160;160 22:17:36 INFO - PROCESS | 13350 | |3;audio-fft;71;73;85;93;72;70;70;100;103;72 22:17:36 INFO - PROCESS | 13350 | |4;audio-oscillator;96;97;136;96;96;95;142;94;95;143 22:17:36 INFO - PROCESS | 13350 | |5;imaging-gaussian-blur;110;109;109;109;109;109;109;110;110;109 22:17:36 INFO - PROCESS | 13350 | |6;imaging-darkroom;145;145;145;145;146;145;145;145;145;146 22:17:36 INFO - PROCESS | 13350 | |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;95 22:17:36 INFO - PROCESS | 13350 | |8;json-parse-financial;58;57;60;67;57;56;57;60;59;54 22:17:36 INFO - PROCESS | 13350 | |9;json-stringify-tinderbox;67;68;69;68;68;68;68;68;67;68 22:17:36 INFO - PROCESS | 13350 | |10;stanford-crypto-aes;83;85;85;86;85;84;91;84;84;85 22:17:36 INFO - PROCESS | 13350 | |11;stanford-crypto-ccm;124;123;113;122;117;119;126;121;128;113 22:17:36 INFO - PROCESS | 13350 | |12;stanford-crypto-pbkdf2;140;150;149;148;147;139;148;159;148;138 22:17:36 INFO - PROCESS | 13350 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;66;73;67;68;67 22:17:36 INFO - PROCESS | 13350 | __end_tp_report 22:17:36 INFO - PROCESS | 13350 | __start_cc_report 22:17:36 INFO - PROCESS | 13350 | _x_x_mozilla_cycle_collect,941 22:17:36 INFO - PROCESS | 13350 | __end_cc_report 22:17:36 INFO - PROCESS | 13350 | __startTimestamp1451110656274__endTimestamp 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | ------- Summary: start ------- 22:17:36 INFO - PROCESS | 13350 | Number of tests: 14 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.41 (3.1%) stddev-sans-first:3.60 22:17:36 INFO - PROCESS | 13350 | Values: 110.0 113.0 108.0 110.0 111.0 110.0 100.0 109.0 109.0 109.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:152.00 stddev:17.05 (11.2%) stddev-sans-first:17.76 22:17:36 INFO - PROCESS | 13350 | Values: 154.0 130.0 145.0 168.0 122.0 162.0 150.0 128.0 163.0 127.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 22:17:36 INFO - PROCESS | 13350 | Values: 160.0 160.0 160.0 160.0 160.0 160.0 157.0 161.0 160.0 160.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#3] audio-fft Cycles:10 Average:80.90 Median:72.00 stddev:13.22 (18.4%) stddev-sans-first:13.53 22:17:36 INFO - PROCESS | 13350 | Values: 71.0 73.0 85.0 93.0 72.0 70.0 70.0 100.0 103.0 72.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.50 stddev:21.71 (22.7%) stddev-sans-first:22.51 22:17:36 INFO - PROCESS | 13350 | Values: 96.0 97.0 136.0 96.0 96.0 95.0 142.0 94.0 95.0 143.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 22:17:36 INFO - PROCESS | 13350 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 22:17:36 INFO - PROCESS | 13350 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:17:36 INFO - PROCESS | 13350 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:3.50 (6.0%) stddev-sans-first:3.71 22:17:36 INFO - PROCESS | 13350 | Values: 58.0 57.0 60.0 67.0 57.0 56.0 57.0 60.0 59.0 54.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 22:17:36 INFO - PROCESS | 13350 | Values: 67.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 67.0 68.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.20 (2.6%) stddev-sans-first:2.19 22:17:36 INFO - PROCESS | 13350 | Values: 83.0 85.0 85.0 86.0 85.0 84.0 91.0 84.0 84.0 85.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:122.50 stddev:5.10 (4.2%) stddev-sans-first:5.26 22:17:36 INFO - PROCESS | 13350 | Values: 124.0 123.0 113.0 122.0 117.0 119.0 126.0 121.0 128.0 113.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:148.00 stddev:6.26 (4.2%) stddev-sans-first:6.16 22:17:36 INFO - PROCESS | 13350 | Values: 140.0 150.0 149.0 148.0 147.0 139.0 148.0 159.0 148.0 138.0 22:17:36 INFO - PROCESS | 13350 | 22:17:36 INFO - PROCESS | 13350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.91 (2.8%) stddev-sans-first:2.00 22:17:36 INFO - PROCESS | 13350 | Values: 67.0 68.0 68.0 68.0 67.0 66.0 73.0 67.0 68.0 67.0 22:17:36 INFO - PROCESS | 13350 | -------- Summary: end -------- 22:17:36 INFO - PROCESS | 13350 | 22:17:38 INFO - TEST-INFO | 13350: exit 0 22:17:38 INFO - TEST-OK | kraken | took 71878ms 22:17:38 INFO - TEST-START | v8_7 22:17:38 INFO - operating with platform_type : linux_ 22:17:38 INFO - Initialising browser for v8_7 test... 22:17:38 INFO - TEST-INFO | started process 13603 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAoeKcS/profile http://localhost:47752/getInfo.html) 22:17:50 INFO - PROCESS | 13603 | __metrics Screen width/height:1600/1200 22:17:50 INFO - PROCESS | 13603 | colorDepth:24 22:17:50 INFO - PROCESS | 13603 | Browser inner width/height: 1024/697 22:17:50 INFO - PROCESS | 13603 | __metrics 22:17:50 INFO - PROCESS | 13603 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:17:50 INFO - PROCESS | 13603 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:17:55 INFO - TEST-INFO | 13603: exit 0 22:17:55 INFO - Browser initialized. 22:17:55 INFO - Running cycle 1/1 for v8_7 test... 22:17:55 INFO - TEST-INFO | started process 13683 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAoeKcS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:18:07 INFO - PROCESS | 13683 | RSS: Main: 148889600 22:18:07 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | Cycle 1(1): loaded http://localhost:47752/tests/v8_7/run.html (next: http://localhost:47752/tests/v8_7/run.html) 22:18:28 INFO - PROCESS | 13683 | RSS: Main: 183603200 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | __start_tp_report 22:18:28 INFO - PROCESS | 13683 | _x_x_mozilla_page_load 22:18:28 INFO - PROCESS | 13683 | _x_x_mozilla_page_load_details 22:18:28 INFO - PROCESS | 13683 | |i|pagename|runs| 22:18:28 INFO - PROCESS | 13683 | |0;Richards;169.26201760324983 22:18:28 INFO - PROCESS | 13683 | |1;DeltaBlue;197.08316909735908 22:18:28 INFO - PROCESS | 13683 | |2;Encrypt;287.85261945883707 22:18:28 INFO - PROCESS | 13683 | |3;Decrypt;5175.257731958763 22:18:28 INFO - PROCESS | 13683 | |4;RayTrace;1111.111111111111 22:18:28 INFO - PROCESS | 13683 | |5;Earley;801.924619085806 22:18:28 INFO - PROCESS | 13683 | |6;Boyer;12562.5 22:18:28 INFO - PROCESS | 13683 | |7;RegExp;25450 22:18:28 INFO - PROCESS | 13683 | |8;Splay;608.272506082725 22:18:28 INFO - PROCESS | 13683 | |9;NavierStokes;4840.579710144928 22:18:28 INFO - PROCESS | 13683 | __end_tp_report 22:18:28 INFO - PROCESS | 13683 | __startTimestamp1451110708770__endTimestamp 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | ------- Summary: start ------- 22:18:28 INFO - PROCESS | 13683 | Number of tests: 10 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#0] Richards Cycles:1 Average:169.26 Median:169.26 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 169.3 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#1] DeltaBlue Cycles:1 Average:197.08 Median:197.08 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 197.1 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#2] Encrypt Cycles:1 Average:287.85 Median:287.85 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 287.9 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 5175.3 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#4] RayTrace Cycles:1 Average:1111.11 Median:1111.11 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 1111.1 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 801.9 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#6] Boyer Cycles:1 Average:12562.50 Median:12562.50 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 12562.5 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 25450.0 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#8] Splay Cycles:1 Average:608.27 Median:608.27 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 608.3 22:18:28 INFO - PROCESS | 13683 | 22:18:28 INFO - PROCESS | 13683 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:18:28 INFO - PROCESS | 13683 | Values: 4840.6 22:18:28 INFO - PROCESS | 13683 | -------- Summary: end -------- 22:18:28 INFO - PROCESS | 13683 | 22:18:30 INFO - TEST-INFO | 13683: exit 0 22:18:30 INFO - TEST-OK | v8_7 | took 51838ms 22:18:30 INFO - SUITE-END | took 1259s 22:18:30 INFO - Completed test suite (00:20:59) 22:18:30 INFO - Working with test: dromaeo_css 22:18:30 INFO - Generating results file: dromaeo_css 22:18:30 INFO - Working with test: kraken 22:18:30 INFO - Generating results file: kraken 22:18:30 INFO - javascript benchmark 22:18:30 INFO - Working with test: v8_7 22:18:30 INFO - Generating results file: v8_7 22:18:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:18:30 INFO - process_Request line: dromaeo_css 6850.98 graph.html#tests=[[72,1,35]] 22:18:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:30 INFO - process_Request line: kraken 1500.40 graph.html#tests=[[232,1,35]] 22:18:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:18:30 INFO - process_Request line: v8_7 20771.04 graph.html#tests=[[230,1,35]] 22:18:30 INFO - RETURN: dromaeo_css: 6850.98 22:18:30 INFO - RETURN: kraken: 1500.40 22:18:30 INFO - RETURN: v8_7: 20771.04 22:18:30 INFO - javascript benchmark 22:18:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3082.198628356627, 3098.876044958202, 3136.341368312653, 3167.952480712789, 3179.2846609512862, 4963.503649635035, 4984.900301993958, 5015.147424937761, 5025.321581586485, 5028.0698070856915, 4837.443693975194, 5010.624203184767, 5042.899142017158, 5136.794528218867, 5173.767180476878, 4646.303054541829, 4659.091477161955, 4701.435827700664, 4714.929276060861, 4735.360726301957, 4538.455385353745, 4629.259318509039, 4650.65120115991, 4660.277656963159, 4726.574608285254, 4575.382323386333, 4576.748278844662, 4588.105319462689, 4611.30830375443, 4640.46634637016, 4513.0296986147805, 4542.38677778499, 4566.429196350457, 4578.793954272066, 4610.608098311647, 4524.705894116872, 4552.499225085238, 4586.839460618862, 4606.838760643395, 4685.461171965234, 4944.381952255968, 4950.455449900508, 4958.057968985881, 4981.452040275567, 5025.974870125626, 5425.267588875491, 5426.457354264581, 5435.1847222916485, 5437.782488700447, 5447.918281225785, 5243.318368612056, 5342.091844386464, 5342.171963345688, 5374.355077390738, 5436.864078398072, 5094.566961808251, 5121.308623335802, 5125.077486052472, 5127.8205262816, 5128.717920514333, 5546.889062218733, 5569.331680198321, 5571.192177134293, 5573.554115670737, 5574.637648552831, 5236.136037553837, 5271.736413179326, 5327.786888524415, 5346.572274218053, 5399.163129714901, 5363.141897296414, 5363.517283444508, 5376.865578360494, 5377.005254028018, 5381.219723140122, 5204.71374074422, 5346.812861549827, 5347.197920311906, 5348.238860744374, 5384.138537833927, 5301.973490132525, 5385.515303622615, 5466.9179962300595, 5478.150886612581, 5532.5573954083575, 4215.936760948588, 4216.451861258017, 4223.408722778813, 4236.830526778956, 4266.018815672351, 3722.181120153562, 3797.240551889578, 3807.2956503047026, 3816.0841398064263, 3841.4237864320576, 5104.948950510522, 5146.253793199965, 5146.356705411824, 5146.356705411824, 5195.922061169085, 5425.430329815392, 5427.104527752956, 5441.0, 5442.755076021588, 5489.505944465017, 5060.645754797202, 5066.9746651266505, 5100.642954993189, 5112.437631860566, 5149.098907691139, 4744.905101897943, 4758.95241047592, 4761.500042495557, 4768.499307572655, 4802.951970480251, 5649.0396632572565, 5673.461021202979, 5675.716214189357, 5676.772929082873, 5677.829665110054, 5243.475652434726, 5333.7866485340155, 5339.492748188916, 5438.15708565173, 5457.863553411196, 5637.774489020393, 5640.379558248672, 5644.717764111696, 5647.463490968352, 5653.067243904709, 5352.5450336721815, 5384.165454354581, 5386.057439948072, 5397.163439666858, 5399.8788997747115, 5245.134552798745, 5363.704996225245, 5435.728213589384, 5487.396386397413, 5527.861803454945, 5323.334583177103, 5331.893362132813, 5332.733363331896, 5335.573154147736, 5339.866503337447, 5305.0, 5327.121025030827, 5330.62685612019, 5330.946690533045, 5377.919331210113, 5110.948890511196, 5120.564751996122, 5202.635815492879, 5206.479352064764, 5224.03355379256, 5259.053370393366, 5261.710605916712, 5265.52610265078, 5266.447023062523, 5273.235380869829, 5169.612279079009, 5170.1986192140275, 5179.8446046618665, 5217.34783152106, 5219.9217011744095], "unit": "score", "name": "dojo.html", "value": 5009.812808259018}, {"lowerIsBetter": false, "replicates": [576.8125359258241, 600.486583970705, 606.390577469643, 606.4420732925713, 620.8168590265873, 28464.00375986841, 29407.852960735192, 36468.63531364689, 36927.0, 37142.8142859286, 39451.0, 40044.59955400445, 40049.39925901114, 40051.19897602046, 40110.39834402479, 7360.300771426706, 8250.752477425656, 8505.489670619752, 8514.148585141498, 8520.914790852104, 7245.818854528627, 7740.961295193544, 10144.289899707024, 10302.742431439237, 10326.896731032668, 10030.147437467787, 10165.0, 10210.38737675738, 10212.029857163558, 10213.438260895648, 7541.660625271876, 9969.252306077036, 10057.949710251474, 10074.949625251827, 10091.949540252324, 7458.0, 10071.395716257048, 10272.948635256851, 10287.12559432449, 10288.74278143045, 36727.0, 37142.44286335707, 37153.0, 37201.627983720085, 37210.0, 3201.9199520011953, 3209.9197520061953, 3236.91907702307, 3246.123546642393, 3254.8698052078125, 28365.432691346057, 28574.142775716762, 28664.856675716488, 29435.264118396997, 30909.690903090905, 3839.155385815116, 3915.3735402335487, 3921.647051765326, 4001.479807625019, 4030.5163380394542, 258869.0, 261221.0, 261393.9999999981, 261462.69268653725, 262014.0, 51096.0, 51936.48063519392, 59384.0, 59654.403455964886, 60230.69884650636, 58575.121373179434, 58873.70563147157, 58900.0, 58955.70522147362, 59219.407805921386, 15865.20673966297, 15999.520014399586, 16012.599685007968, 16014.519564413085, 16025.19874006295, 11668.299902005907, 11845.289282643069, 11879.643610691694, 11879.643610691694, 11981.700457488458, 19257.32599359044, 19275.325363612206, 19544.631875768842, 19623.116959736846, 19632.509187270432, 6789.592624442549, 7303.342699157101, 7360.190379058299, 7364.600725862069, 7421.332080112816, 962.5331714118647, 1005.1807776661997, 1012.8632634594383, 1029.6653587583914, 1132.4790596325618, 28276.293092672848, 31058.0, 31262.0, 31271.374572508423, 31498.0, 982.5480279071564, 1006.8691070160833, 1063.532325390971, 1114.5820317380983, 1152.4065106470175, 15203.543893683207, 15635.921820390826, 15742.449014284444, 15791.131487768283, 15914.60213494672, 329529.0, 329982.0, 330887.0, 331654.0, 332141.0, 52835.735821320646, 53073.0, 53087.73456132694, 53178.46821531735, 53183.0, 1237.975240495185, 1246.7070238493948, 1277.1379318959664, 1338.6118025772416, 1359.7756370198806, 25922.22233333003, 26255.606165907146, 26457.735422645528, 26706.0, 26854.328641784112, 39710.0, 39973.20053598854, 40089.59910400859, 40132.59867401289, 40163.1967360657, 294788.0, 299864.0, 312421.0, 316793.0, 316889.0, 28734.712652873204, 28806.703698334044, 28820.711792881804, 28826.42347153087, 28853.85573072121, 38321.23357532889, 39700.602993970846, 39911.800440997606, 40104.197916042096, 40404.0, 36536.08659783527, 36594.26811463809, 36741.44887826631, 37979.810100950424, 38174.23651526898, 36228.63771362358, 37000.81499592485, 37378.6262137386, 37761.65740939717, 37917.43123853199, 35734.4639830408, 36210.8189459051, 36376.81811590925, 36473.635263647026, 36842.44736328904, 32316.515252270765, 33220.33559328751, 33481.33037339191, 33564.0, 33808.32383352368, 25161.0, 25269.87365063163, 25385.365365866, 25650.358741031625, 26118.608220877082], "unit": "score", "name": "ext.html", "value": 18412.090309288284}, {"lowerIsBetter": false, "replicates": [361.55348145040887, 363.30427231851, 363.50926249563094, 366.0446235325801, 366.43203035295295, 14063.789043164335, 14112.294385280746, 16073.0, 17354.56613584661, 18395.81604183958, 14357.856421435783, 14391.136531808099, 14427.990040697156, 14831.258437078157, 14836.703265934702, 5202.635815492917, 5315.388730296027, 5327.760250788704, 5328.600354973373, 5332.68003919766, 4010.1979604079156, 4133.958660413387, 5284.365876094855, 5344.599155063366, 5741.770329186827, 5830.0, 5846.269216347957, 5846.561507886904, 5860.208871802295, 5871.618344807595, 5712.6286791358425, 5830.912536311958, 5870.999999999979, 5876.147958546029, 5883.058710606325, 5199.428062913076, 5203.869903252411, 5205.27126202332, 5213.478652134794, 5220.556252718524, 19384.515387115294, 20305.0, 20381.0, 20400.897995510077, 20917.790822091738, 2109.841761867866, 2248.4716091718433, 2271.5570463759573, 2406.7713567211085, 2489.3154382544762, 12947.935260323733, 13227.801582976263, 13241.602751917362, 13554.86445135546, 13623.18260904349, 1805.1515787579947, 1822.4168266154836, 1828.7988321284647, 1839.8868684445852, 1843.483824529134, 57532.13701794476, 59501.7024914877, 60099.0, 60660.966951652685, 60915.39084609142, 9723.270754693427, 10048.899511004942, 10050.74873128163, 10052.497375131361, 10118.0, 13211.801822972662, 13274.20798192251, 13291.534796282083, 13309.866901331057, 13313.40089695966, 7630.542167469969, 7688.0005599271735, 7722.961385193151, 7758.806029849299, 7812.492188007761, 7522.924770752332, 7535.886961695579, 7575.166731659513, 7586.734464293833, 7598.658060387296, 5896.528277737771, 5974.372690867396, 5992.64044157352, 5995.190649262381, 6035.336113027563, 1652.6942515634646, 1707.795064592232, 1716.2963185094052, 1741.5820203151407, 1802.9368972085913, 933.8459154239474, 948.9240860731124, 1023.0690072034562, 1045.3100953370738, 1101.0896095274693, 14606.269686515632, 16185.919070404809, 17058.402955896483, 17444.0, 17764.378246761302, 915.3729695158837, 964.6527250189926, 978.9804203916025, 1010.4796030044533, 1044.8223801953686, 9487.430754154773, 9705.223582113415, 9999.0, 10021.448820314952, 10064.74838129038, 471056.0, 477709.0, 477859.0, 491039.0, 501859.0, 77240.0, 78264.82602760963, 80402.95970402913, 81022.18977810147, 82981.58509207415, 1192.7674103549898, 1193.7612477504533, 1212.2605210821391, 1217.7868872947377, 1230.2311055590255, 15563.37746490173, 15639.374425022872, 15724.606884827514, 15926.761098583762, 15941.44204952821, 33780.83109584436, 34065.14837129092, 34526.48210276898, 34658.0, 34674.306513870084, 44614.3307850389, 45000.77499612481, 45014.77492612516, 45313.0, 48813.51186488089, 9685.564149613143, 9821.459819709698, 9834.803303934024, 9908.157806586521, 9929.007099290013, 12033.75932481328, 16716.749248761036, 17380.04409757425, 17444.825551744827, 17551.122443878012, 13832.515861944783, 14005.929970350084, 14040.1575905446, 14363.066400683922, 14414.13515189092, 13712.725745485233, 14227.0, 14439.2058436787, 14462.349194286073, 14491.275436228358, 11549.538018479503, 12199.0, 14305.21321327337, 14387.712245754818, 14814.40742370293, 9597.520123993912, 9601.903980960102, 9695.51522423862, 9739.513024348897, 9771.0, 3001.5647731078434, 11960.0, 13670.794938076137, 13706.931465343008, 14618.561443156723], "unit": "score", "name": "jquery.html", "value": 8961.33402523886}, {"lowerIsBetter": false, "replicates": [1328.8671132886707, 1437.6405898525368, 1446.3636000159925, 1584.6592982508766, 1767.9933275732049, 6476.967615161923, 7154.928450715492, 7254.528455650379, 7263.0194923685285, 7271.709131634741, 6859.554128981613, 6982.965085174567, 6991.510594258404, 6994.860102797941, 7003.509754317187, 2163.9891800540977, 2199.120351859261, 2202.1631779923605, 2202.526456811785, 2206.415299945516, 2190.5071358944188, 2205.52581195043, 2293.86236825791, 2305.965410518844, 2308.53829234153, 2233.106757297078, 2238.910443582263, 2252.538229662915, 2271.0, 2287.9885600571974, 2082.1879467007802, 2101.5271563898154, 2119.6290649136495, 2120.9257675981344, 2123.2462475821094, 2244.9214277500373, 2281.783230593091, 2284.3603790938564, 2285.645724912641, 2292.0, 7185.928140718631, 7262.600556969364, 7278.053852999129, 7282.271772822728, 7310.4517161213125, 4300.677449191292, 4375.518692943773, 4377.934330985037, 4407.0524837160165, 4413.470383553962, 3022.8337441440713, 3060.066679662702, 3062.5406189071596, 3068.6777888321853, 3091.2890035291784, 970.1801977329145, 979.750163708257, 980.2990861533966, 997.5361456922493, 1012.8126296635072, 9787.706368808947, 9803.068708472754, 9805.264605154642, 9834.9508252459, 9848.852267215998, 4037.253108174997, 4054.878353649395, 4079.3676980068135, 4103.0, 4113.239050775616, 8393.454425462325, 8393.832123357499, 8398.538080405637, 8402.537860417613, 8410.411271210956, 4387.166438376698, 4418.425604671436, 4425.579569940851, 4428.0, 4429.158459892675, 3652.8538858445363, 3726.757760745543, 4010.19796040793, 4012.3179059559943, 4093.099518106012, 3398.218409765718, 3402.591688997336, 3418.1283772637817, 3433.364827506919, 3439.2949445363643, 1128.08061429936, 1134.8184290513477, 1136.6590022993234, 1141.6289705845634, 1142.4744617475887, 1292.7479141567303, 1293.32100647161, 1311.4360824845216, 1317.0517227596115, 1317.808917706927, 6856.417204537571, 6910.06714093601, 6939.063226464464, 6947.965260173768, 6964.547304425196, 462.94213223347083, 473.73234122720555, 474.7673639916485, 478.9784459699322, 479.94480634726756, 5474.370447398521, 5478.506934375925, 5497.45025497447, 5522.696251706195, 5533.22534845122, 8639.265662418766, 8667.4366166199, 8863.2466240369, 8971.05803890595, 8973.820523589491, 8772.517511536798, 8877.556122193864, 8894.59974301158, 8924.286057115416, 8942.552872356357, 6875.07186529812, 6978.860422791618, 6984.0, 6992.091028166407, 7000.124984376953, 6764.797056088325, 6780.491463140383, 6785.796426107225, 6788.287229840796, 6796.830079248059, 7707.344875685405, 7927.60361981887, 7934.087579928382, 8048.83902321962, 8052.315553178046, 8002.479838810692, 8159.632816523389, 8171.918280817115, 8272.296854767412, 8292.958535207285, 6591.802245932629, 6647.9002814958785, 6693.464522838064, 6695.598264104169, 6701.128853249046, 7182.712691492491, 7206.063211782434, 7239.927600723925, 7240.05879235696, 7281.817954551178, 6546.116274302908, 6771.119754431892, 6834.419074378733, 6841.213260475109, 6952.304769523007, 6710.765123220859, 6761.628110453972, 6775.186977562724, 6839.589624622538, 6853.760118395832, 6376.234851817811, 6431.0, 6481.578697384655, 6499.772507962199, 6507.0, 5833.183354330312, 5863.618864773776, 5873.853153671193, 5880.735366908414, 5883.499902508334, 6017.669028203491, 6057.515398768, 6064.909026364519, 6068.817935461943, 6072.90890636632], "unit": "score", "name": "mootools.html", "value": 4190.475501028427}, {"lowerIsBetter": false, "replicates": [342.8971308607417, 348.2634228606498, 349.58574089703694, 352.4185094593921, 357.2159110751899, 5892.351841297454, 5986.341502434729, 6041.093835924614, 6051.576389652726, 6054.8789024219595, 5746.885062298762, 5839.0, 5875.911861322073, 5938.40615938406, 5946.672932988684, 4635.83774567891, 4655.837045703401, 4658.464276608182, 4658.86023419298, 4660.603848672867, 4418.050119224366, 4495.258282383403, 4499.482559505666, 4655.394798676168, 4658.720476771387, 4598.563136502027, 4611.423572053493, 4626.329182268569, 4635.443746750395, 4635.930461043087, 4606.97696511517, 4612.031473390592, 4618.076384723069, 4619.63042956566, 4620.838270660511, 4096.32410652242, 4099.672026237924, 4103.4050062740735, 4103.630673239393, 4109.849242212185, 5558.44415558445, 5677.205191273225, 5689.857753556194, 5690.772369105231, 5697.03150464422, 5400.432954539795, 5408.2428460015235, 5408.432114627986, 5412.91880621791, 5417.945820541823, 6349.047642853563, 6349.174607301067, 6351.809445716636, 6357.300696923335, 6358.936410635881, 4344.391785150082, 4414.205443020255, 4433.490148632916, 4510.909781804346, 4516.322551617251, 6569.0474881142445, 6602.768903088417, 6629.535932484728, 6632.104665870094, 6638.302978187317, 4670.252759558454, 4679.532046795293, 4680.602148817388, 4682.0, 4683.157031734252, 4613.7312239133835, 4720.95279047212, 4742.478327383985, 4745.549172828576, 4747.738874361874, 5353.705546194997, 5384.6499977501335, 5386.649867758583, 5390.622656414092, 5391.433899440581, 6402.775902843378, 6406.871862562816, 6408.903866442007, 6410.61536307823, 6411.551191416556, 1663.1767275198854, 1683.9158042097847, 1686.047383228472, 1687.2829047654698, 1688.8226736192523, 1142.2118738070706, 1145.5818626201376, 1147.8565179352581, 1152.458344578047, 1167.9824802627968, 6064.241969753781, 6073.969630151821, 6080.0, 6084.908726369108, 6095.359987201368, 6529.902051469232, 6568.376004279586, 6577.375149360803, 6583.670816459158, 6585.703643336062, 5965.821025369246, 6048.0625503047095, 6085.786997455068, 6092.116643086816, 6103.084537319438, 3552.7335449841366, 3576.1774791798034, 3579.6957258632788, 3581.426971684518, 3583.086312990171, 6760.628165450948, 6835.043093966849, 6838.0, 6842.247352791189, 6845.657717114124, 6699.062131301622, 6713.12729345182, 6717.328267173243, 6732.596044237362, 6738.191417029988, 6718.596884186964, 6812.318768123148, 6852.109225800714, 6861.794146175623, 6862.588244705234, 6385.553011289351, 6630.966845165936, 6640.867182656417, 6648.936170212743, 6659.367360100783, 6378.266499352634, 6479.676016199265, 6497.4477169441125, 6500.772472963424, 6502.707378168088, 6843.3840954314355, 6854.417374523022, 6860.3139686031, 6912.896306555305, 6915.101036865175, 4535.591796738177, 4567.429071366079, 4569.423548875632, 4573.245414506569, 4576.702514336557, 6444.516661250331, 6573.474122070318, 6589.736410543716, 6593.208814942046, 6600.966995164993, 6410.647414392067, 6425.10048593188, 6452.483801295979, 6491.318411566906, 6493.480521558358, 6200.658963757037, 6454.0, 6475.449586785176, 6477.093206950936, 6477.995910633671, 6293.0, 6296.559240853279, 6302.527310451643, 6307.148534947723, 6318.557700960889, 6493.2857385688485, 6496.805095847132, 6497.8700425992165, 6500.869982600227, 6510.837229069311, 6223.657698826427, 6359.491240700825, 6362.109304697254, 6363.268224154096, 6365.427111559982], "unit": "score", "name": "prototype.html", "value": 4851.993038599525}, {"lowerIsBetter": false, "replicates": [768.0821418405009, 777.2072486064211, 792.0086328940985, 800.691733682532, 844.7719115838723, 12786.232826030433, 12997.155184912974, 13005.479780808768, 13006.0, 13020.34898255087, 12692.0, 12780.424880880359, 12939.870601293984, 13419.597412077628, 13452.0, 681.264234626602, 701.6281370873445, 820.5733018830205, 833.6957010691115, 833.9791505212388, 814.2549567146084, 840.684743221292, 847.5719761520423, 847.9745607631781, 848.3637272045966, 862.5514732339179, 869.6434461870634, 870.0951010948637, 871.9869201961976, 873.135595760196, 713.2439614009141, 735.2500449541465, 859.8968123825118, 865.1002956924791, 879.7712594725417, 643.8486955565485, 644.1046944746805, 645.0646562484417, 648.1962366665301, 649.0523835200613, 12556.81164782529, 12616.369181540886, 12643.178193417398, 12721.681957951032, 12763.87236127636, 10598.523066462029, 11410.54357825686, 11420.828687569694, 11465.426728663617, 11972.64082077539, 10054.296199266055, 10338.276320657556, 10583.84124238137, 10588.417637029961, 10824.350538967608, 3403.0, 3442.345954268706, 3448.827558622059, 3454.5336379588935, 3525.806080665562, 46968.76515617434, 46996.53003469956, 47089.29366059512, 47399.526004740204, 47426.76286618545, 7764.107127680389, 8024.79938001543, 8044.316233120133, 8119.431639785158, 8340.874886876702, 16047.598810029842, 16115.919420402823, 16141.35434582627, 16171.757423638655, 16182.0, 7616.200298968639, 7706.113796913314, 7762.486776953911, 7849.843003140019, 8007.279344858991, 4222.725522841006, 4254.532001479834, 4313.158934007838, 4315.503717072514, 4383.7588932609015, 3061.4336347775734, 3114.828684422333, 3117.173948903542, 3120.4851199551817, 3121.2977080156784, 579.5537436174122, 583.5777271131175, 588.7380115848406, 589.9292084949833, 598.2701104652317, 611.929628092775, 617.6201635993831, 628.5725706519611, 643.9742410303535, 646.809191288571, 7847.097583777939, 8050.4364694472, 8058.194180582012, 8068.8386232275025, 8249.29880960125, 551.8923809857039, 631.3844002098009, 640.545212898847, 652.8922727749868, 653.9378759017885, 3646.5988741238443, 3809.542854857435, 3846.288436639231, 3869.7097717671286, 3940.0, 55377.16934245989, 57397.71301143467, 57522.0, 57550.7122464385, 57703.4229657698, 48526.0, 50067.0, 50463.747681262095, 50617.0, 51408.74295628498, 44737.776311118236, 44996.55003449989, 45374.773126134816, 46269.0, 46664.7666761664, 8012.238837310446, 8083.636236369495, 8177.6320065596, 8202.179782021989, 8320.126386729306, 35384.11539711528, 35941.28117437584, 36269.0932726684, 36644.26711465809, 36733.63266367302, 42112.78943605385, 42354.576454235066, 45114.77442612766, 45373.54626453693, 46357.0, 9611.903880961101, 10049.447280399649, 10084.425903853911, 10338.948305258426, 10652.09457196147, 11348.886511134782, 11467.4266286687, 11908.486702472092, 12871.554404663084, 12983.091183617056, 10667.94618045138, 10752.784944301227, 10889.401082940514, 10988.615398461336, 11385.259958102697, 11740.354280514654, 12102.092343074128, 12123.0, 12296.0, 12616.17994830333, 10496.580136794748, 10794.19043571751, 10893.07408870255, 11151.498182581965, 11248.437578120898, 9083.591238394156, 9298.535073246447, 9307.0, 9317.86023209666, 9833.950830245803, 8807.559622019002, 9022.413543119676, 9194.49430281341, 9513.476758778057, 9727.811242470387], "unit": "score", "name": "yui.html", "value": 6151.679244165199}], "name": "dromaeo_css", "value": 6850.980902767724}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 108.0, 110.0, 111.0, 110.0, 100.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [154.0, 130.0, 145.0, 168.0, 122.0, 162.0, 150.0, 128.0, 163.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 160.0, 157.0, 161.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 159.8}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 85.0, 93.0, 72.0, 70.0, 70.0, 100.0, 103.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 136.0, 96.0, 96.0, 95.0, 142.0, 94.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 60.0, 67.0, 57.0, 56.0, 57.0, 60.0, 59.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 86.0, 85.0, 84.0, 91.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [124.0, 123.0, 113.0, 122.0, 117.0, 119.0, 126.0, 121.0, 128.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [140.0, 150.0, 149.0, 148.0, 147.0, 139.0, 148.0, 159.0, 148.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 66.0, 73.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1500.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.26201760324983], "unit": "score", "name": "Richards", "value": 208.56421600000007}, {"lowerIsBetter": false, "replicates": [197.08316909735908], "unit": "score", "name": "DeltaBlue", "value": 335.48273200000006}, {"lowerIsBetter": false, "replicates": [287.85261945883707], "unit": "score", "name": "Encrypt", "value": 924.7127939999998}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1111.111111111111], "unit": "score", "name": "RayTrace", "value": 665.9901}, {"lowerIsBetter": false, "replicates": [801.924619085806], "unit": "score", "name": "Earley", "value": 831.079361}, {"lowerIsBetter": false, "replicates": [12562.5], "unit": "score", "name": "Boyer", "value": 53.05178109452737}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [608.272506082725], "unit": "score", "name": "Splay", "value": 133.97120400000006}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20771.035529208122}]} 22:18:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20771.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1500.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6850.98"}}} 22:18:30 INFO - Return code: 0 22:18:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:18:30 INFO - # TBPL SUCCESS # 22:18:30 INFO - Running post-action listener: _resource_record_post_action 22:18:30 INFO - Running post-run listener: _resource_record_post_run 22:18:31 INFO - Total resource usage - Wall time: 1282s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548446208; Read time: 2340; Write time: 4559620 22:18:31 INFO - install - Wall time: 17s; CPU: 26.0%; Read bytes: 0; Write bytes: 139186176; Read time: 0; Write time: 836624 22:18:31 INFO - run-tests - Wall time: 1266s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394211328; Read time: 2340; Write time: 3434932 22:18:31 INFO - Running post-run listener: _upload_blobber_files 22:18:31 INFO - Blob upload gear active. 22:18:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:18:31 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 22:18:31 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'] 22:18:31 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 22:18:32 INFO - (blobuploader) - INFO - Open directory for files ... 22:18:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:18:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:18:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:18:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:18:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:18:32 INFO - (blobuploader) - INFO - Done attempting. 22:18:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:18:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:18:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:18:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:18:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:18:33 INFO - (blobuploader) - INFO - Done attempting. 22:18:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:18:33 INFO - Return code: 0 22:18:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:18:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:18:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95de53221caca95a59e2b4688c8b8a6b3447cea007079147048b23534e993b34b7aa06d7c60b341b18be85b3eea0cbbf984632b054fbbafbae8500c16b1b33ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee9f670846e6f2ae9f0ff6e4f1b05ec608fac0bedcb373dcf224368769adfb6f1a167430111c7acd1f58cfbe19aafb53e5d1275a31e39aeaedded309a9afc01"} 22:18:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:18:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:18:33 INFO - Contents: 22:18:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95de53221caca95a59e2b4688c8b8a6b3447cea007079147048b23534e993b34b7aa06d7c60b341b18be85b3eea0cbbf984632b054fbbafbae8500c16b1b33ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee9f670846e6f2ae9f0ff6e4f1b05ec608fac0bedcb373dcf224368769adfb6f1a167430111c7acd1f58cfbe19aafb53e5d1275a31e39aeaedded309a9afc01"} 22:18:33 INFO - Copying logs to upload dir... 22:18:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1327.994666 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-12-25 22:18:33.789887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 22:18:33.793397) ========= 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=256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710 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/95de53221caca95a59e2b4688c8b8a6b3447cea007079147048b23534e993b34b7aa06d7c60b341b18be85b3eea0cbbf984632b054fbbafbae8500c16b1b33ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee9f670846e6f2ae9f0ff6e4f1b05ec608fac0bedcb373dcf224368769adfb6f1a167430111c7acd1f58cfbe19aafb53e5d1275a31e39aeaedded309a9afc01"} build_url:https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/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/95de53221caca95a59e2b4688c8b8a6b3447cea007079147048b23534e993b34b7aa06d7c60b341b18be85b3eea0cbbf984632b054fbbafbae8500c16b1b33ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee9f670846e6f2ae9f0ff6e4f1b05ec608fac0bedcb373dcf224368769adfb6f1a167430111c7acd1f58cfbe19aafb53e5d1275a31e39aeaedded309a9afc01"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 22:18:33.817525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:18:33.817828) ========= 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=256b35f542ca8bede9e27f1f00000291-1451108942.311434-711831710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:18:33.899821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 22:18:33.900137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 22:18:33.900427) ========= ========= Total master_lag: 0.26 =========