builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1451402249.06 results: success (0) buildid: 20151229043001 builduid: 5773e6c0f17249b9ad7c605c177a0565 revision: 9ddf0da90fb3bc1ae29966dc596013fc54a44bd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.060290) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.060762) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.061188) ========= 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=5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006450 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.095250) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.095588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.157717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.158062) ========= 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=5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.213634) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.213918) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.214324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.214593) ========= 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=5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 07:17:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.6M=0s 2015-12-29 07:17:31 (60.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.396432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.396752) ========= 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=5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013952 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.446815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.447226) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ddf0da90fb3bc1ae29966dc596013fc54a44bd2 --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 9ddf0da90fb3bc1ae29966dc596013fc54a44bd2 --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=5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 07:17:31,907 truncating revision to first 12 chars 2015-12-29 07:17:31,907 Setting DEBUG logging. 2015-12-29 07:17:31,907 attempt 1/10 2015-12-29 07:17:31,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ddf0da90fb3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 07:17:32,149 unpacking tar archive at: mozilla-central-9ddf0da90fb3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.974795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.975128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.986290) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.986568) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:29.986961) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-29 07:17:29.987250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:17:32 INFO - MultiFileLogger online at 20151229 07:17:32 in /builds/slave/test-pgo 07:17:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:17:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:17:32 INFO - {'append_to_log': False, 07:17:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:17:32 INFO - 'blob_upload_branch': 'Firefox', 07:17:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:17:32 INFO - 'branch': 'Firefox', 07:17:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:17:32 INFO - 'config_files': ('talos/linux_config.py',), 07:17:32 INFO - 'default_actions': ('clobber', 07:17:32 INFO - 'read-buildbot-config', 07:17:32 INFO - 'download-and-extract', 07:17:32 INFO - 'populate-webroot', 07:17:32 INFO - 'create-virtualenv', 07:17:32 INFO - 'install', 07:17:32 INFO - 'run-tests'), 07:17:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:17:32 INFO - 'download_minidump_stackwalk': True, 07:17:32 INFO - 'download_symbols': 'ondemand', 07:17:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:17:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:17:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:17:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:17:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:17:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:17:32 INFO - 'installer_path': 'installer.exe', 07:17:32 INFO - 'log_level': 'info', 07:17:32 INFO - 'log_name': 'talos', 07:17:32 INFO - 'log_to_console': True, 07:17:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:17:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:17:32 INFO - 'opt_config_files': (), 07:17:32 INFO - 'pip_index': False, 07:17:32 INFO - 'sps_profile': False, 07:17:32 INFO - 'sps_profile_interval': 0, 07:17:32 INFO - 'suite': 'dromaeojs-e10s', 07:17:32 INFO - 'system_bits': '32', 07:17:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:17:32 INFO - 'title': 'talos-linux64-ix-059', 07:17:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:17:32 INFO - 'use_talos_json': True, 07:17:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:17:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:17:32 INFO - 'work_dir': 'build'} 07:17:32 INFO - ##### 07:17:32 INFO - ##### Running clobber step. 07:17:32 INFO - ##### 07:17:32 INFO - Running pre-action listener: _resource_record_pre_action 07:17:32 INFO - Running main action method: clobber 07:17:32 INFO - rmtree: /builds/slave/test-pgo/build 07:17:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:17:33 INFO - Running post-action listener: _resource_record_post_action 07:17:33 INFO - ##### 07:17:33 INFO - ##### Running read-buildbot-config step. 07:17:33 INFO - ##### 07:17:33 INFO - Running pre-action listener: _resource_record_pre_action 07:17:33 INFO - Running main action method: read_buildbot_config 07:17:33 INFO - Using buildbot properties: 07:17:33 INFO - { 07:17:33 INFO - "project": "", 07:17:33 INFO - "product": "firefox", 07:17:33 INFO - "script_repo_revision": "production", 07:17:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:17:33 INFO - "repository": "", 07:17:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:17:33 INFO - "buildid": "20151229043001", 07:17:33 INFO - "pgo_build": "True", 07:17:33 INFO - "basedir": "/builds/slave/test-pgo", 07:17:33 INFO - "buildnumber": 278, 07:17:33 INFO - "slavename": "talos-linux64-ix-059", 07:17:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:17:33 INFO - "platform": "ubuntu64_hw", 07:17:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:17:33 INFO - "branch": "mozilla-central", 07:17:33 INFO - "repo_path": "mozilla-central", 07:17:33 INFO - "revision": "9ddf0da90fb3bc1ae29966dc596013fc54a44bd2", 07:17:33 INFO - "stage_platform": "linux64-pgo", 07:17:33 INFO - "builduid": "5773e6c0f17249b9ad7c605c177a0565", 07:17:33 INFO - "slavebuilddir": "test" 07:17:33 INFO - } 07:17:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:17:33 INFO - Running post-action listener: _resource_record_post_action 07:17:33 INFO - ##### 07:17:33 INFO - ##### Running download-and-extract step. 07:17:33 INFO - ##### 07:17:33 INFO - Running pre-action listener: _resource_record_pre_action 07:17:33 INFO - Running main action method: download_and_extract 07:17:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:17:33 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')]} 07:17:33 INFO - https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:17:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/test_packages.json 07:17:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/test_packages.json 07:17:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:17:37 INFO - Downloaded 1302 bytes. 07:17:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:17:37 INFO - Using the following test package requirements: 07:17:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:17:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:37 INFO - u'jsshell-linux-x86_64.zip'], 07:17:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:17:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:17:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:17:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:17:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:17:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:17: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')]} 07:17:37 INFO - https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:17:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:17:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:17:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/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 07:17:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/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 07:17:41 INFO - Downloaded 23192066 bytes. 07:17:41 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 07:17:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:17:41 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 07:17:42 INFO - Return code: 0 07:17:42 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 07:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:42 INFO - https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/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 07:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/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 07:17:51 INFO - Downloaded 23192066 bytes. 07:17:51 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 07:17:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:17:51 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 07:17:53 INFO - Return code: 0 07:17:53 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')]} 07:17:53 INFO - https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:17:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/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 07:17:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/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 07:17:54 INFO - Downloaded 11132270 bytes. 07:17:54 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 07:17:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:54 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 07:17:54 INFO - Return code: 0 07:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:54 INFO - https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/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 07:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/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 07:17:55 INFO - Downloaded 54913574 bytes. 07:17:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:17:55 INFO - mkdir: /builds/slave/test-pgo/properties 07:17:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:17:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:17:55 INFO - Contents: 07:17:55 INFO - build_url:https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:17:55 INFO - Running post-action listener: _resource_record_post_action 07:17:55 INFO - Running post-action listener: set_extra_try_arguments 07:17:55 INFO - ##### 07:17:55 INFO - ##### Running populate-webroot step. 07:17:55 INFO - ##### 07:17:55 INFO - Running pre-action listener: _resource_record_pre_action 07:17:55 INFO - Running main action method: populate_webroot 07:17:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:55 INFO - '--tppagecycles', 07:17:55 INFO - '7'], 07:17:55 INFO - 'tests': ['tsvgm']}}, 07:17:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:17:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:17:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:17:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:55 INFO - 'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:55 INFO - 'tests': ['damp', 'tps']}, 07:17:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:55 INFO - 'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['damp', 'tps']}, 07:17:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:17:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:55 INFO - 'other': {'tests': ['a11yr', 07:17:55 INFO - 'ts_paint', 07:17:55 INFO - 'tpaint', 07:17:55 INFO - 'sessionrestore', 07:17:55 INFO - 'sessionrestore_no_auto_restore']}, 07:17:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['a11yr', 07:17:55 INFO - 'ts_paint', 07:17:55 INFO - 'tpaint', 07:17:55 INFO - 'sessionrestore', 07:17:55 INFO - 'sessionrestore_no_auto_restore']}, 07:17:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['a11yr', 07:17:55 INFO - 'ts_paint', 07:17:55 INFO - 'tpaint', 07:17:55 INFO - 'sessionrestore', 07:17:55 INFO - 'sessionrestore_no_auto_restore']}, 07:17:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['a11yr', 07:17:55 INFO - 'ts_paint', 07:17:55 INFO - 'tpaint', 07:17:55 INFO - 'sessionrestore', 07:17:55 INFO - 'sessionrestore_no_auto_restore']}, 07:17:55 INFO - 'other_l64': {'tests': ['a11yr', 07:17:55 INFO - 'ts_paint', 07:17:55 INFO - 'tpaint', 07:17:55 INFO - 'sessionrestore', 07:17:55 INFO - 'sessionrestore_no_auto_restore']}, 07:17:55 INFO - 'other_nol64': {'tests': ['a11yr', 07:17:55 INFO - 'ts_paint', 07:17:55 INFO - 'tpaint', 07:17:55 INFO - 'sessionrestore', 07:17:55 INFO - 'sessionrestore_no_auto_restore']}, 07:17:55 INFO - 'svgr': {'tests': ['tsvgx', 07:17:55 INFO - 'tsvgr_opacity', 07:17:55 INFO - 'tart', 07:17:55 INFO - 'tscrollx', 07:17:55 INFO - 'cart']}, 07:17:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['tsvgx', 07:17:55 INFO - 'tsvgr_opacity', 07:17:55 INFO - 'tart', 07:17:55 INFO - 'tscrollx', 07:17:55 INFO - 'cart']}, 07:17:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:55 INFO - 'tests': ['tp5o']}, 07:17:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:55 INFO - 'talos_options': ['--e10s'], 07:17:55 INFO - 'tests': ['tp5o']}, 07:17:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:55 INFO - 'talos_options': ['--xperf_path', 07:17:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:55 INFO - 'tests': ['tp5n']}, 07:17:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:55 INFO - 'talos_options': ['--e10s', 07:17:55 INFO - '--xperf_path', 07:17:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:55 INFO - 'tests': ['tp5n']}}, 07:17:55 INFO - 'talos.zip': {'path': '', 07:17:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:55 INFO - Running post-action listener: _resource_record_post_action 07:17:55 INFO - ##### 07:17:55 INFO - ##### Running create-virtualenv step. 07:17:55 INFO - ##### 07:17:55 INFO - Running pre-action listener: _resource_record_pre_action 07:17:55 INFO - Running main action method: create_virtualenv 07:17:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:17:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:17:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:17:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:55 INFO - Using real prefix '/usr' 07:17:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:17:56 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:58 INFO - Installing pip.................done. 07:17:58 INFO - Return code: 0 07:17:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:17: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')]} 07:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:17:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:17:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:17:58 INFO - Using env: {'DISPLAY': ':0', 07:17:58 INFO - 'HOME': '/home/cltbld', 07:17:58 INFO - 'LANG': 'en_US.UTF-8', 07:17:58 INFO - 'LANGUAGE': 'en_US:en', 07:17:58 INFO - 'LOGNAME': 'cltbld', 07:17:58 INFO - 'MAIL': '/var/mail/cltbld', 07:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:58 INFO - 'MOZ_NO_REMOTE': '1', 07:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:58 INFO - 'NO_EM_RESTART': '1', 07:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:17:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:17:58 INFO - 'SHELL': '/bin/bash', 07:17:58 INFO - 'SHLVL': '1', 07:17:58 INFO - 'TERM': 'linux', 07:17:58 INFO - 'TMOUT': '86400', 07:17:58 INFO - 'USER': 'cltbld', 07:17:58 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:58 INFO - '_': '/tools/buildbot/bin/python'} 07:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:17:58 INFO - Cleaning up... 07:17:58 INFO - Return code: 0 07:17:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:17: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')]} 07:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:17:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:17:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:17:58 INFO - Using env: {'DISPLAY': ':0', 07:17:58 INFO - 'HOME': '/home/cltbld', 07:17:58 INFO - 'LANG': 'en_US.UTF-8', 07:17:58 INFO - 'LANGUAGE': 'en_US:en', 07:17:58 INFO - 'LOGNAME': 'cltbld', 07:17:58 INFO - 'MAIL': '/var/mail/cltbld', 07:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:58 INFO - 'MOZ_NO_REMOTE': '1', 07:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:58 INFO - 'NO_EM_RESTART': '1', 07:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:17:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:17:58 INFO - 'SHELL': '/bin/bash', 07:17:58 INFO - 'SHLVL': '1', 07:17:58 INFO - 'TERM': 'linux', 07:17:58 INFO - 'TMOUT': '86400', 07:17:58 INFO - 'USER': 'cltbld', 07:17:58 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:58 INFO - '_': '/tools/buildbot/bin/python'} 07:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:58 INFO - Downloading/unpacking psutil>=0.7.1 07:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:18:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:18:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:00 INFO - Installing collected packages: psutil 07:18:00 INFO - Running setup.py install for psutil 07:18:00 INFO - building 'psutil._psutil_linux' extension 07:18:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:18:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:18:00 INFO - building 'psutil._psutil_posix' extension 07:18:00 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 07:18:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:18:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:00 INFO - Successfully installed psutil 07:18:00 INFO - Cleaning up... 07:18:01 INFO - Return code: 0 07:18:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:18:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:18:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:18:01 INFO - Using env: {'DISPLAY': ':0', 07:18:01 INFO - 'HOME': '/home/cltbld', 07:18:01 INFO - 'LANG': 'en_US.UTF-8', 07:18:01 INFO - 'LANGUAGE': 'en_US:en', 07:18:01 INFO - 'LOGNAME': 'cltbld', 07:18:01 INFO - 'MAIL': '/var/mail/cltbld', 07:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:01 INFO - 'MOZ_NO_REMOTE': '1', 07:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:01 INFO - 'NO_EM_RESTART': '1', 07:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:01 INFO - 'SHELL': '/bin/bash', 07:18:01 INFO - 'SHLVL': '1', 07:18:01 INFO - 'TERM': 'linux', 07:18:01 INFO - 'TMOUT': '86400', 07:18:01 INFO - 'USER': 'cltbld', 07:18:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:01 INFO - '_': '/tools/buildbot/bin/python'} 07:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:18:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:18:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:18:02 INFO - Installing collected packages: mozsystemmonitor 07:18:02 INFO - Running setup.py install for mozsystemmonitor 07:18:03 INFO - Successfully installed mozsystemmonitor 07:18:03 INFO - Cleaning up... 07:18:03 INFO - Return code: 0 07:18:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:18:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:18:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:18:03 INFO - Using env: {'DISPLAY': ':0', 07:18:03 INFO - 'HOME': '/home/cltbld', 07:18:03 INFO - 'LANG': 'en_US.UTF-8', 07:18:03 INFO - 'LANGUAGE': 'en_US:en', 07:18:03 INFO - 'LOGNAME': 'cltbld', 07:18:03 INFO - 'MAIL': '/var/mail/cltbld', 07:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:03 INFO - 'MOZ_NO_REMOTE': '1', 07:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:03 INFO - 'NO_EM_RESTART': '1', 07:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:03 INFO - 'SHELL': '/bin/bash', 07:18:03 INFO - 'SHLVL': '1', 07:18:03 INFO - 'TERM': 'linux', 07:18:03 INFO - 'TMOUT': '86400', 07:18:03 INFO - 'USER': 'cltbld', 07:18:03 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:03 INFO - '_': '/tools/buildbot/bin/python'} 07:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:18:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:18:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:18:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:18:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:18:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:05 INFO - Downloading docopt-0.6.1.tar.gz 07:18:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:18:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:18:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:18:05 INFO - Running setup.py install for blobuploader 07:18:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:18:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:18:05 INFO - Running setup.py install for requests 07:18:06 INFO - Running setup.py install for docopt 07:18:06 INFO - Successfully installed blobuploader requests docopt 07:18:06 INFO - Cleaning up... 07:18:06 INFO - Return code: 0 07:18:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:18:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:18:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:06 INFO - Using env: {'DISPLAY': ':0', 07:18:06 INFO - 'HOME': '/home/cltbld', 07:18:06 INFO - 'LANG': 'en_US.UTF-8', 07:18:06 INFO - 'LANGUAGE': 'en_US:en', 07:18:06 INFO - 'LOGNAME': 'cltbld', 07:18:06 INFO - 'MAIL': '/var/mail/cltbld', 07:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:06 INFO - 'MOZ_NO_REMOTE': '1', 07:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:06 INFO - 'NO_EM_RESTART': '1', 07:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:06 INFO - 'SHELL': '/bin/bash', 07:18:06 INFO - 'SHLVL': '1', 07:18:06 INFO - 'TERM': 'linux', 07:18:06 INFO - 'TMOUT': '86400', 07:18:06 INFO - 'USER': 'cltbld', 07:18:06 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:06 INFO - '_': '/tools/buildbot/bin/python'} 07:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:18:06 INFO - Running setup.py (path:/tmp/pip-8z5dEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:18:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:18:06 INFO - Running setup.py (path:/tmp/pip-Jyjbsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:18:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:18:06 INFO - Running setup.py (path:/tmp/pip-BbhpCa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:18:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:18:06 INFO - Running setup.py (path:/tmp/pip-FFah3x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:18:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:18:06 INFO - Running setup.py (path:/tmp/pip-bFn3Zw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:18:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:18:06 INFO - Running setup.py (path:/tmp/pip-GoaEor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:18:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:18:06 INFO - Running setup.py (path:/tmp/pip-5xDLxt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:18:07 INFO - Running setup.py (path:/tmp/pip-Wl9dfT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:18:07 INFO - Running setup.py (path:/tmp/pip-YO6YNO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:18:07 INFO - Running setup.py (path:/tmp/pip-9QmN0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:18:07 INFO - Running setup.py (path:/tmp/pip-Wp8Sra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:18:07 INFO - Running setup.py (path:/tmp/pip-4pCIZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:18:07 INFO - Running setup.py (path:/tmp/pip-LXy8xa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:18:07 INFO - Running setup.py (path:/tmp/pip-EaYAgt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:18:07 INFO - Running setup.py (path:/tmp/pip-LFgf2p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:18:07 INFO - Running setup.py (path:/tmp/pip-02jgQU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:18:07 INFO - Running setup.py (path:/tmp/pip-RMi35Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:18:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:18:07 INFO - Running setup.py install for manifestparser 07:18:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:18:07 INFO - Running setup.py install for mozcrash 07:18:07 INFO - Running setup.py install for mozdebug 07:18:08 INFO - Running setup.py install for mozdevice 07:18:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Running setup.py install for mozfile 07:18:08 INFO - Running setup.py install for mozhttpd 07:18:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Running setup.py install for mozinfo 07:18:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Running setup.py install for mozInstall 07:18:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Running setup.py install for mozleak 07:18:08 INFO - Running setup.py install for mozlog 07:18:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Running setup.py install for moznetwork 07:18:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Running setup.py install for mozprocess 07:18:09 INFO - Running setup.py install for mozprofile 07:18:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:18:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:18:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:18:09 INFO - Running setup.py install for mozrunner 07:18:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:18:09 INFO - Running setup.py install for mozscreenshot 07:18:09 INFO - Running setup.py install for moztest 07:18:09 INFO - Running setup.py install for mozversion 07:18:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:18:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:09 INFO - Cleaning up... 07:18:09 INFO - Return code: 0 07:18:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:18:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:18:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:09 INFO - Using env: {'DISPLAY': ':0', 07:18:09 INFO - 'HOME': '/home/cltbld', 07:18:09 INFO - 'LANG': 'en_US.UTF-8', 07:18:09 INFO - 'LANGUAGE': 'en_US:en', 07:18:09 INFO - 'LOGNAME': 'cltbld', 07:18:09 INFO - 'MAIL': '/var/mail/cltbld', 07:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:09 INFO - 'MOZ_NO_REMOTE': '1', 07:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:09 INFO - 'NO_EM_RESTART': '1', 07:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:09 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:09 INFO - 'SHELL': '/bin/bash', 07:18:09 INFO - 'SHLVL': '1', 07:18:09 INFO - 'TERM': 'linux', 07:18:09 INFO - 'TMOUT': '86400', 07:18:09 INFO - 'USER': 'cltbld', 07:18:09 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:09 INFO - '_': '/tools/buildbot/bin/python'} 07:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:18:09 INFO - Running setup.py (path:/tmp/pip-uCzi4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:18:09 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)) 07:18:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:18:09 INFO - Running setup.py (path:/tmp/pip-NLApor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:18:09 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)) 07:18:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:18:09 INFO - Running setup.py (path:/tmp/pip-tocfSi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:18:09 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)) 07:18:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:18:10 INFO - Running setup.py (path:/tmp/pip-2AxDDJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:18:10 INFO - Running setup.py (path:/tmp/pip-xUYaDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:18:10 INFO - Running setup.py (path:/tmp/pip-LKnLoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:18:10 INFO - Running setup.py (path:/tmp/pip-395Dpu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:18:10 INFO - Running setup.py (path:/tmp/pip-oMgdJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:18:10 INFO - Running setup.py (path:/tmp/pip-H0RsUP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:18:10 INFO - Running setup.py (path:/tmp/pip-_1NHF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:18:10 INFO - Running setup.py (path:/tmp/pip-PSVdIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:18:10 INFO - Running setup.py (path:/tmp/pip-bJSmvr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:18:10 INFO - Running setup.py (path:/tmp/pip-CLlZ0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:18:10 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)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:18:10 INFO - Running setup.py (path:/tmp/pip-lrc_y1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:18:10 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)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:18:10 INFO - Running setup.py (path:/tmp/pip-bn3lVs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:18:10 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)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:18:10 INFO - Running setup.py (path:/tmp/pip-YTf7S7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:18:10 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)) 07:18:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:18:10 INFO - Running setup.py (path:/tmp/pip-NMoPk6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:18:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:12 INFO - Downloading blessings-1.5.1.tar.gz 07:18:12 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 07:18:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:18:12 INFO - Installing collected packages: blessings 07:18:12 INFO - Running setup.py install for blessings 07:18:12 INFO - Successfully installed blessings 07:18:12 INFO - Cleaning up... 07:18:12 INFO - Return code: 0 07:18:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:18:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:18:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:18:13 INFO - Reading from file tmpfile_stdout 07:18:13 INFO - Current package versions: 07:18:13 INFO - argparse == 1.2.1 07:18:13 INFO - blessings == 1.5.1 07:18:13 INFO - blobuploader == 1.2.4 07:18:13 INFO - docopt == 0.6.1 07:18:13 INFO - manifestparser == 1.1 07:18:13 INFO - mozInstall == 1.12 07:18:13 INFO - mozcrash == 0.16 07:18:13 INFO - mozdebug == 0.1 07:18:13 INFO - mozdevice == 0.47 07:18:13 INFO - mozfile == 1.2 07:18:13 INFO - mozhttpd == 0.7 07:18:13 INFO - mozinfo == 0.9 07:18:13 INFO - mozleak == 0.1 07:18:13 INFO - mozlog == 3.1 07:18:13 INFO - moznetwork == 0.27 07:18:13 INFO - mozprocess == 0.22 07:18:13 INFO - mozprofile == 0.28 07:18:13 INFO - mozrunner == 6.11 07:18:13 INFO - mozscreenshot == 0.1 07:18:13 INFO - mozsystemmonitor == 0.0 07:18:13 INFO - moztest == 0.7 07:18:13 INFO - mozversion == 1.4 07:18:13 INFO - psutil == 3.1.1 07:18:13 INFO - requests == 1.2.3 07:18:13 INFO - wsgiref == 0.1.2 07:18:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:18:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:18:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:18:13 INFO - Using env: {'DISPLAY': ':0', 07:18:13 INFO - 'HOME': '/home/cltbld', 07:18:13 INFO - 'LANG': 'en_US.UTF-8', 07:18:13 INFO - 'LANGUAGE': 'en_US:en', 07:18:13 INFO - 'LOGNAME': 'cltbld', 07:18:13 INFO - 'MAIL': '/var/mail/cltbld', 07:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:13 INFO - 'MOZ_NO_REMOTE': '1', 07:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:13 INFO - 'NO_EM_RESTART': '1', 07:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:13 INFO - 'SHELL': '/bin/bash', 07:18:13 INFO - 'SHLVL': '1', 07:18:13 INFO - 'TERM': 'linux', 07:18:13 INFO - 'TMOUT': '86400', 07:18:13 INFO - 'USER': 'cltbld', 07:18:13 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:13 INFO - '_': '/tools/buildbot/bin/python'} 07:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:18:13 INFO - Cleaning up... 07:18:13 INFO - Return code: 0 07:18:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:18:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:18:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:18:13 INFO - Using env: {'DISPLAY': ':0', 07:18:13 INFO - 'HOME': '/home/cltbld', 07:18:13 INFO - 'LANG': 'en_US.UTF-8', 07:18:13 INFO - 'LANGUAGE': 'en_US:en', 07:18:13 INFO - 'LOGNAME': 'cltbld', 07:18:13 INFO - 'MAIL': '/var/mail/cltbld', 07:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:13 INFO - 'MOZ_NO_REMOTE': '1', 07:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:13 INFO - 'NO_EM_RESTART': '1', 07:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:13 INFO - 'SHELL': '/bin/bash', 07:18:13 INFO - 'SHLVL': '1', 07:18:13 INFO - 'TERM': 'linux', 07:18:13 INFO - 'TMOUT': '86400', 07:18:13 INFO - 'USER': 'cltbld', 07:18:13 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:13 INFO - '_': '/tools/buildbot/bin/python'} 07:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:13 INFO - Downloading/unpacking jsonschema 07:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:18:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:18:15 INFO - Downloading/unpacking functools32 (from jsonschema) 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:15 INFO - Downloading functools32-3.2.3-2.tar.gz 07:18:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:18:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:18:15 INFO - warning: no files found matching '*.txt' 07:18:15 INFO - no previously-included directories found matching 'build' 07:18:15 INFO - no previously-included directories found matching 'dist' 07:18:15 INFO - no previously-included directories found matching '.git*' 07:18:15 INFO - Installing collected packages: jsonschema, functools32 07:18:15 INFO - Running setup.py install for functools32 07:18:15 INFO - warning: no files found matching '*.txt' 07:18:15 INFO - no previously-included directories found matching 'build' 07:18:15 INFO - no previously-included directories found matching 'dist' 07:18:15 INFO - no previously-included directories found matching '.git*' 07:18:15 INFO - Successfully installed jsonschema functools32 07:18:15 INFO - Cleaning up... 07:18:15 INFO - Return code: 0 07:18:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f735bd19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2070630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, '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': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', '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 07:18:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:18:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:18:15 INFO - Using env: {'DISPLAY': ':0', 07:18:15 INFO - 'HOME': '/home/cltbld', 07:18:15 INFO - 'LANG': 'en_US.UTF-8', 07:18:15 INFO - 'LANGUAGE': 'en_US:en', 07:18:15 INFO - 'LOGNAME': 'cltbld', 07:18:15 INFO - 'MAIL': '/var/mail/cltbld', 07:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:15 INFO - 'MOZ_NO_REMOTE': '1', 07:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:15 INFO - 'NO_EM_RESTART': '1', 07:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:15 INFO - 'SHELL': '/bin/bash', 07:18:15 INFO - 'SHLVL': '1', 07:18:15 INFO - 'TERM': 'linux', 07:18:15 INFO - 'TMOUT': '86400', 07:18:15 INFO - 'USER': 'cltbld', 07:18:15 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:15 INFO - '_': '/tools/buildbot/bin/python'} 07:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:15 INFO - Downloading/unpacking flake8 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:18:17 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 07:18:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:18:17 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 07:18:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:17 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 07:18:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:18:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:18:18 INFO - no previously-included directories found matching 'docs/_build' 07:18:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:18:18 INFO - Running setup.py install for pep8 07:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:18:18 INFO - no previously-included directories found matching 'docs/_build' 07:18:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:18:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:18:18 INFO - Cleaning up... 07:18:18 INFO - Return code: 0 07:18:18 INFO - Running post-action listener: _resource_record_post_action 07:18:18 INFO - Running post-action listener: _start_resource_monitoring 07:18:18 INFO - Starting resource monitoring. 07:18:18 INFO - ##### 07:18:18 INFO - ##### Running install step. 07:18:18 INFO - ##### 07:18:18 INFO - Running pre-action listener: _resource_record_pre_action 07:18:18 INFO - Running main action method: install 07:18:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:18:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:18:18 INFO - Reading from file tmpfile_stdout 07:18:18 INFO - Detecting whether we're running mozinstall >=1.0... 07:18:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:18:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:18:18 INFO - Reading from file tmpfile_stdout 07:18:18 INFO - Output received: 07:18:18 INFO - Usage: mozinstall [options] installer 07:18:18 INFO - Options: 07:18:18 INFO - -h, --help show this help message and exit 07:18:18 INFO - -d DEST, --destination=DEST 07:18:18 INFO - Directory to install application into. [default: 07:18:18 INFO - "/builds/slave/test-pgo"] 07:18:18 INFO - --app=APP Application being installed. [default: firefox] 07:18:18 INFO - mkdir: /builds/slave/test-pgo/build/application 07:18:18 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'] 07:18:18 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 07:18:34 INFO - Reading from file tmpfile_stdout 07:18:34 INFO - Output received: 07:18:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:18:34 INFO - Running post-action listener: _resource_record_post_action 07:18:34 INFO - ##### 07:18:34 INFO - ##### Running run-tests step. 07:18:34 INFO - ##### 07:18:34 INFO - Running pre-action listener: _resource_record_pre_action 07:18:34 INFO - Running main action method: run_tests 07:18:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:18:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:18:34 INFO - Python 2.7.3 07:18:34 INFO - Return code: 0 07:18:34 INFO - grabbing minidump binary from tooltool 07:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:18:34 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 0x2101840>, '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 0x206e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:18:34 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 07:18:34 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 07:18:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:34 INFO - Return code: 0 07:18:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:18:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:18:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:18:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:18:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:18:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:18:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:18:35 INFO - Return code: 0 07:18:35 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 07:18:35 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:18:35 INFO - Using env: {'DISPLAY': ':0', 07:18:35 INFO - 'HOME': '/home/cltbld', 07:18:35 INFO - 'LANG': 'en_US.UTF-8', 07:18:35 INFO - 'LANGUAGE': 'en_US:en', 07:18:35 INFO - 'LOGNAME': 'cltbld', 07:18:35 INFO - 'MAIL': '/var/mail/cltbld', 07:18:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:18:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:35 INFO - 'MOZ_NO_REMOTE': '1', 07:18:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:35 INFO - 'NO_EM_RESTART': '1', 07:18:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:35 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:18:35 INFO - 'SHELL': '/bin/bash', 07:18:35 INFO - 'SHLVL': '1', 07:18:35 INFO - 'TERM': 'linux', 07:18:35 INFO - 'TMOUT': '86400', 07:18:35 INFO - 'USER': 'cltbld', 07:18:35 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723', 07:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:35 INFO - '_': '/tools/buildbot/bin/python'} 07:18:35 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:18:35 INFO - mozversion application_buildid: 20151229043001 07:18:35 INFO - mozversion application_changeset: 9ddf0da90fb3bc1ae29966dc596013fc54a44bd2 07:18:35 INFO - mozversion application_display_name: Nightly 07:18:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:35 INFO - mozversion application_name: Firefox 07:18:35 INFO - mozversion application_remotingname: firefox 07:18:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:18:35 INFO - mozversion application_vendor: Mozilla 07:18:35 INFO - mozversion application_version: 46.0a1 07:18:35 INFO - mozversion platform_buildid: 20151229043001 07:18:35 INFO - mozversion platform_changeset: 9ddf0da90fb3bc1ae29966dc596013fc54a44bd2 07:18:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:18:35 INFO - mozversion platform_version: 46.0a1 07:18:35 INFO - using testdate: 1451402315 07:18:35 INFO - actual date: 1451402315 07:18:35 INFO - starting webserver on 'localhost:42189' 07:18:35 INFO - SUITE-START | Running 3 tests 07:18:35 INFO - TEST-START | dromaeo_css 07:18:35 INFO - operating with platform_type : linux_ 07:18:35 INFO - Initialising browser for dromaeo_css test... 07:18:35 INFO - TEST-INFO | started process 25980 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZHvFua/profile http://localhost:42189/getInfo.html) 07:18:40 INFO - PROCESS | 25980 | __metrics Screen width/height:1600/1200 07:18:40 INFO - PROCESS | 25980 | colorDepth:24 07:18:40 INFO - PROCESS | 25980 | Browser inner width/height: 1024/697 07:18:40 INFO - PROCESS | 25980 | __metrics 07:18:40 INFO - PROCESS | 25980 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:18:41 INFO - TEST-INFO | 25980: exit 0 07:18:41 INFO - Browser initialized. 07:18:41 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:41 INFO - TEST-INFO | started process 26112 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZHvFua/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:52 INFO - PROCESS | 26112 | RSS: Main: 149577728 07:18:52 INFO - PROCESS | 26112 | 07:19:42 INFO - PROCESS | 26112 | 1451402382460 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] 07:21:51 INFO - PROCESS | 26112 | Cycle 1(1): loaded http://localhost:42189/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42189/tests/dromaeo/cssquery-ext.html) 07:21:52 INFO - PROCESS | 26112 | RSS: Main: 156356608 07:21:52 INFO - PROCESS | 26112 | 07:24:54 INFO - PROCESS | 26112 | Cycle 1(1): loaded http://localhost:42189/tests/dromaeo/cssquery-ext.html (next: http://localhost:42189/tests/dromaeo/cssquery-jquery.html) 07:24:54 INFO - PROCESS | 26112 | RSS: Main: 152809472 07:24:54 INFO - PROCESS | 26112 | 07:27:56 INFO - PROCESS | 26112 | Cycle 1(1): loaded http://localhost:42189/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42189/tests/dromaeo/cssquery-mootools.html) 07:27:57 INFO - PROCESS | 26112 | RSS: Main: 152502272 07:27:57 INFO - PROCESS | 26112 | 07:30:58 INFO - PROCESS | 26112 | Cycle 1(1): loaded http://localhost:42189/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42189/tests/dromaeo/cssquery-prototype.html) 07:30:59 INFO - PROCESS | 26112 | RSS: Main: 152006656 07:30:59 INFO - PROCESS | 26112 | 07:34:01 INFO - PROCESS | 26112 | Cycle 1(1): loaded http://localhost:42189/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42189/tests/dromaeo/cssquery-yui.html) 07:34:02 INFO - PROCESS | 26112 | RSS: Main: 152727552 07:34:02 INFO - PROCESS | 26112 | 07:37:04 INFO - PROCESS | 26112 | Cycle 1(1): loaded http://localhost:42189/tests/dromaeo/cssquery-yui.html (next: http://localhost:42189/tests/dromaeo/cssquery-dojo.html) 07:37:05 INFO - PROCESS | 26112 | RSS: Main: 154656768 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - PROCESS | 26112 | __start_tp_report 07:37:05 INFO - PROCESS | 26112 | _x_x_mozilla_page_load 07:37:05 INFO - PROCESS | 26112 | _x_x_mozilla_page_load_details 07:37:05 INFO - PROCESS | 26112 | |i|pagename|runs| 07:37:05 INFO - PROCESS | 26112 | |0;dojo.html;3138.843057847108;3203.1992001999515;3212.486002239642;3248.074298824835;3250.7074363307297;5144.125498665227;5247.239150323206;5247.317848679671;5253.264542963988;5269.73651317434;5077.822276220333;5079.161938280179;5161.380634323877;5214.921776173351;5312.92030619541;4744.64415168862;4792.712437253767;4827.058723548909;4881.438634557018;4910.926336104962;4529.569690879362;4844.636652251095;4862.902741945159;4914.336564563774;4932.161532539477;4655.068986202756;4716.740579268139;4741.359916411292;4793.880152996168;4801.855944321676;4704.317873908264;4711.387519622462;4724.881877953045;4732.834350797705;4746.050789842011;4630.097131059411;4690.226112691402;4694;4735.266033764772;4756;4991.351124353847;5013.824516141917;5024.673396229234;5028.270900719412;5064.746762661889;5621.578381621394;5639.323281206241;5643.435656434365;5648.4633959773755;5692.886142277172;5663.801766938137;5674.659520428788;5676.886462270772;5679.119736440858;5679.261695979496;5041.168207245837;5146.974265128651;5166.715830629276;5276.630635855492;5286.207068939651;5830.271216097988;5839.708014599253;5854.648721076749;5856.531477481792;5861.765529378862;5592.468715472024;5617.691026993472;5618.185363122325;5634.859128521738;5639.238702775155;5484.780608775604;5583.134614134816;5585.497305242467;5587.776488940478;5659.462351076641;5468.453154684579;5494.313210848644;5501.862453438696;5501.9174712379345;5506.752196151183;5523.447655234525;5594.049011668027;5640.464155905182;5666.631668941505;5710.057840456278;4373.6282415994365;4374.168907907488;4379.233634114017;4380.14587155508;4410.514843367227;3834.884953451401;3941.507311586052;3944.092858642471;3973.145773658677;3984.7210695251056;5093.261477085802;5120.052790233819;5156.690598564023;5173;5191.22131680251;5618.381977982419;5641.379448260688;5660.094384898396;5661.801836935688;5667.829965101054;5116.104681680766;5156.071907056766;5159.535641792257;5166.225066240094;5206.97396513015;4757.35775670287;4765.642576806753;4780.402449693788;4784.258439941815;4829.372181616367;5797.652140871562;5801.274840644919;5807.303123625192;5838.649681019152;5854.912176317359;5388.919166212589;5511.145772405283;5595.468430499096;5602.2717046783655;5613.410591887956;5843.444872737083;5857.150713146655;5858.355580886185;5864.296284445893;5888.617239879394;5586.804461843816;5588.944110558842;5591.580631452739;5599.944000559943;5605.019121653613;5516.475934786189;5618.52242559387;5633.295838020247;5663.9716801415725;5730;5395.514403703685;5400.675959442446;5401.864953376197;5404.378496472956;5425.728713564385;5308.708021058725;5310.964361949537;5373.382061062872;5375.381831089318;5381.73091345439;5162.8967420652125;5298.867528311823;5355.518003379714;5377.892442151213;5471.50756431923;5450.291462109901;5471.069918113851;5515.172724091419;5556.305461817273;5580.358258800127;5334.359876814652;5379.784808607768;5396.109641909041;5457.836264912059;5515.669059856261 07:37:05 INFO - PROCESS | 26112 | |1;ext.html;492.9507049295071;539.4928766959056;543.793358523761;559.0105513241563;570.4723131103731;28527.429451410986;35769.642303576955;36461.817690911506;36600.63399366012;36640.81679591602;39199.80400097996;39828.402573961415;39915.40126898099;39927.401088983686;39964.40053399194;8396.748097557067;8491.108433614474;8508.446950948199;8556.5293908835;8558.400911936167;8282.875756863652;8353.913991181138;8369.246767790897;8404.831903361928;8436;8436.072032076467;8464.280536154403;8500.489970601784;8507.149285071506;8514.531700756455;8254.752357429286;8333.541655208961;8370.079291277954;8407.663693452285;8421.915780842175;8357.874631880526;8443.408961372706;8444.746657600283;8458.238758511763;8680.262177714902;38109;38928.22143557142;39067.41398879019;39158.60841391578;39174.21651566981;3328.8502017409273;3419.196488825124;3503.2993401319836;3758.68051215647;3949.822257998397;29348.853255733797;29964.400711985858;30019.5497067542;30107.397852043054;30126.24684382886;3851.73037887348;3916.4712763777097;3944.6252606002386;3981.7212795104356;4080.6531444827224;259976;260625;261013;261564.6921765398;261622;51477.48522514802;53356.466435335926;58067.70966145142;58638;59170.11244831331;53521.46478535243;53602;54056.72971635117;54066.45933540693;54126;15435.151066691215;15653.686926261411;15723.292451839694;15817.209139542976;15825.366985320457;11975.401229938469;12020.278783273032;12073.939630301968;12081.395930203455;12195.024398048135;18982;19348.032598370308;20078.19687212495;20232.494187645425;20239.79760202379;7482.925170748223;7654.961725191339;7720.691172353043;7773.766786996286;7831.412644051719;934.0472717827778;934.6495064350869;1000.5047501486665;1062.9202809789142;1069.893010698924;28697;29043.56434653482;29575.408491830043;29667.40665186684;29861.85069074684;1057.9047885690325;1059.0944742245424;1071.8713754349371;1086.1093902999623;1147.5983405807901;15473.148976806384;15772.842271577367;16584.419545315857;16682.999020058836;16841.242144103544;478148;491488;492174;492228;493029;50253.74873125684;50624.74687626538;50653.240201397006;50724.23913641298;50798;1355.4645914863574;1357.911735737174;1361.8161548191263;1362.7887677410017;1378.1593228130832;26553.734462655128;28681.83769858305;28699.569506457836;28729.42541149207;28815.855920720263;43952.34071488994;44356.778216110004;44434;44439;44457.555424445345;248700;250528;251614;252967;253393;31456.842715786275;31996;32339.514907275938;32429.837850810596;32531;37976.620233798414;38329.4250586247;38558.228835423695;38936;39332.2133557333;33557.3288534223;35347.11632209215;35726;35963.64036359708;37214.81392593128;32847.83576082104;32959.83520082384;33249.66750332466;34387.82806085954;36922.8153859229;35599.46600800938;35601.46597800983;35711.285774283846;35798.46302305415;35842.4623630651;30804.53793193059;31711;32773.67226327706;32971.835140825104;32985.83507082449;24993.500129996934;25332.60670663131;25373.873130634227;25389.51858925058;25752.871235643703 07:37:05 INFO - PROCESS | 26112 | |2;jquery.html;348.9357459747769;350.8964855367667;351.47805508819397;355.69943397828825;355.87366484897876;15999.440019599317;17122;17169.484915452525;17764.733528997076;18588.442346729604;10396.376217426941;10637.680869573906;15642.217889105556;15658.451954181606;15777.92111039446;5009.098362294776;6618.536702430832;6695.765648202314;6705.664716764167;6722.798316050502;5327.627066105355;6639.535232533724;6643.468522518211;6646.9667651661675;6758.290379510155;6751.054852320679;6756.8310792230095;6760.256371799098;6769.424598909099;6780.288069752679;6348.174737284146;6721;6866.931330686704;6913.827154321132;6915.343042410963;6464.191976003;6526.379993900572;6536.313687062885;6539.44414724749;6585.341465853424;22548.43628909274;23150.76849231503;23169.189078382176;23610.409739756473;24128.155514556907;2389.342930694073;2415.0098459631467;2437.24445421918;2451.105346548497;2473.3816545863533;8758.255548278405;13910.51313204033;14022.298885055809;14435.35040923161;14730.263486825615;1909.4653497020718;1955.2081407030175;2000.1499362770764;2001.129508663736;2033.8169564739096;67924.66037669829;73127.63436182839;73425;73803.26196738018;74214.62892685556;15007.399704011717;15543.922280388526;15576.688466230611;15580;15589.454369097028;12641.747165056648;13108.934455327662;13120.671983200305;24475;24588.6311705321;7381.446391520657;7423.183449820515;7604.657790399446;7646.655900484491;7653.57905315213;7498.137714162941;7517.361024312994;7612.657430415645;7615.048118985127;7626.885596716053;4338.219120558267;4343.978280108579;4372.562743725602;4384.298512238027;4391.890202744893;1822.571695651521;1845.0571338714728;1849.6670599292256;1865.2632210276865;1885.8585606079598;872.4154816273112;1012.0335079998583;1034.7930413917247;1061.0874647802884;1075.2419544221304;16070.43753468623;16188.919055404647;16631.671565980774;16726.581835453966;16828.326866925432;974.6637410093506;975.2734213011211;987.1609132237684;1009.7828966772179;1026.6560702164709;7177.605231712306;9330.720078397659;9472.384295020802;9534.28492863038;9694.22446204302;527268;532706;536901;564632;582993;42608.360874586906;42682.78658606687;49331.013379732205;81471;82593;1189.5539172810197;1197.060307658484;1226.8405107335989;1232.383808095952;1241.6647505173553;14998.775018374516;15373.923130384277;15433.382664693736;15541.91206615526;15561.45534906318;31765.841170794;31988;32651.510227346134;33539.83230083834;34328.656713432545;40014.79992600018;41123;41267;41505;44165.337519936584;9455.385399948982;9486.383385079947;9751.951240243754;9763.609455621696;9885.456299903575;11405.885941140483;11456.369899655265;11463.31220126795;11584.07327413788;11689.357085360387;13621.79567306511;14367.784483232968;14468.927655362077;14661.340239689027;14912.328945197276;13868.653283667989;14087.788683169965;14159.362828672529;14841;14879.256037198313;14040.017198796395;14088.506902258781;14151.363188656329;14961;15218.847811522186;9486.478243696387;9535.189508891544;9652;9767.951160244438;9790.80418391614;14804.111753294406;14816.333265002886;15079.396824126912;15203.31585078652;15213.467528636445 07:37:05 INFO - PROCESS | 26112 | |3;mootools.html;1426.4579459805273;1462.765957446808;1597.2892063031948;1734.7397890316442;1758.5076178669976;6779.9661001694985;6866.073080134181;6892.2418533961345;6914.619695916723;7011.158660960692;6955.374016338541;6964.6865891034895;7026.262242464544;7030.472714546404;7037.472189585776;2155.892205389728;2182.7053347798;2191.0359441845535;2193.1556350804976;2201.5927053495075;2120.756113047004;2127.2660931978444;2242.0807468937737;2243.764404737495;2244.932652020442;2098.9475263118393;2124.362691192644;2132.3816093332916;2139.6255655260343;2156.0728886578763;2196.791304826047;2203;2239.675247089163;2252.324302709189;2256.638937769957;2185.715856938604;2193.9780602193932;2210.292706333974;2217.124235926816;2224.877631730254;6878.071460352839;6921.515493915428;6925.030495730602;6957;6966.477514186406;4283.1433713257475;4351.586599273064;4372.1692878353015;4379.5182529921685;4407.757573333465;2848.7151284871557;2865.584490248923;2884.293348129722;2887.5235586128265;2902.983955615539;916.5783739479847;920.9953950230273;922.7370199493113;942.6700654770775;948.1798244518511;9269.351145419823;9300.674476393362;9331.486768227745;9365.531723413802;9373.859392109123;3904;3927.646511813893;3940.4286378474962;3960.7227494075714;4048.5951404859866;7461.925380746232;7478.2147874473485;7491.812704682317;7504.812379690442;7511.661975211128;4406.735595864195;4422.20400327944;4423;4460.3532487789735;4474.373587697725;4058.0869304406274;4079.02103495159;4084.101497670508;4084.7549147051272;4099.528554216244;3132.9530057049164;3152.085895090444;3183.4110689522513;3185.61772587291;3188.713015828587;997.6757553795046;1000.0399616368222;1004.5379125602159;1005.1757558801712;1011.2769369900557;1040.245821779219;1057.4606950455322;1062.4103622489438;1175.26545908807;1291.5285920639087;6499.05763664266;6509.349065093547;6523.967380163069;6530.934690653033;6531.11829902957;1187.2045729361348;1187.7624475105013;1212.1030437476204;1212.8665846756849;1219.9264647110485;5260.894782104337;5270.60470464709;5278.340207474066;5304.071787437183;5321.201819727072;7630.122535908442;8092.352611791042;8121.431499795076;8183.754487365389;8189.672413103528;7992.440529163019;8023.799405014921;8066.354691624656;8101.392395570356;8169.142240064826;6612.173478315211;6652.501062420338;6721.428678562279;6730.360615741497;6802.591844489248;6440.13058237132;6483.708233129426;6487.545871789118;6494.7077381517;6502.60984340941;7330.083739532559;7359.411247100112;7483.775486735407;7555.848883022419;7577.848443031219;7607.581583012766;7628.122765881994;7778.649960751666;7783.961080194563;7837.6864925404625;5977.3126090500145;5995.370486098896;6020;6021.488173505301;6050.485708714808;6524.412802847766;6620.66896655175;6625.138731964814;6646.867062658816;6652.168478940132;6227.377262273736;6280.7487700491465;6337.683115844282;6354.936450635434;6382.457491113308;5688.288963879515;6170.259568851767;6240;6271.560990730605;6313.179286692701;6370.394812492806;6381.680915954091;6413.422791948747;6451.548391612542;6479.8056058318325;5887.8233652990475;5951.970240148771;5962.314333851489;5969.820905372846;5976.19321391624;6032.788852390146;6043.637381757108;6056.5154787616;6057.151998720271;6065.120557519223 07:37:05 INFO - PROCESS | 26112 | |4;prototype.html;333.4747772258692;338.34530184093796;339.06249220904186;344.1980186166232;345.16642308824174;6220.409061139185;6279.623222606635;6316.242050953886;6394.168758061445;6396.712147953342;6085.452309292163;6292.811215663526;6312.873742525147;6325.146105275787;6332.936670633292;4837.927431088537;4849.515048495157;4851.781669824866;4853.757312134397;4853.927191092136;4858.125537403266;4859.441164266102;4859.878503037417;4866.51334866514;4867.245576935581;4725.243960966246;4802.111609352281;4804.015176888747;4839.225723884179;4844.2733589961435;4787.234042553192;4805.783739731721;4810.879728006793;4811.735354555498;4819.686720363183;4170.457840480748;4184.790760461995;4184.979075104605;4190.371444283352;4191.832326706958;5945;5986.940130598682;5991.820245392645;5992.700364981733;5998.28020637522;5491.560675145979;5597.384287728347;5600.5799565032785;5608.383077861432;5628.85927851807;6658.700358483879;6679.632620205887;6680.198376194888;6687.565308254948;6708.396244338033;4623.352730617683;4634.165850146972;4641.976790116061;4644.396228490308;4649.418822647169;6786;6955.130608673916;6962.408195303406;6995.230524642286;6997.265287144827;4627.629789616823;4666.020135771526;4668.276417155346;4670.159371313196;4679.368285281512;4722.433308003062;4733.621310295168;4736.1238170937795;4739.454962679267;4742.857714268508;5526.032944234743;5531.115021596525;5532.585056120807;5534.142207957773;5534.501894829485;6576.145101136917;6690.431313338323;6732.865342693217;6741.561798483083;6756.662166891636;1642.6304081581789;1663.3679201903442;1679.6724638695582;1680.4118558504426;1686.3254698120604;1103.5475455063386;1113.2930589075995;1119.076761671608;1125.926814757038;1133.2973556394923;6129.049997250433;6240.594361366497;6245.532299909518;6271.655058971709;6274.341194174637;6859.519833611699;6872.450203983769;6874.072000279998;6874.6562671867205;6892.862142757117;6009.879802403927;6197.163382943335;6230.532710046765;6242.09489624002;6247.406496382836;3729.850805967731;3738.6635202831876;3740.0836794985403;3753.174301653632;3755;7143.178534468602;7158.821029474305;7163.068801055933;7166.426685865118;7166.713331466787;6939.444844412435;6982.406495447843;6990;6990.266022067712;6990.965045174741;7272.454565907472;7272.563646181352;7290.198078211392;7294.96352518234;7314.561126332437;6952.304769523007;6989;7000.859982800417;7025.789226323219;7042.084529011196;6723.26044135135;6833.384995350442;6867.725290988505;6868.793936181923;6932.0988271524375;7312.780616581511;7318.085239345082;7325.890111648223;7331.303526165006;7331.936869154049;4696.31903374002;4721.173794586002;4726.669133160645;4731.526847315241;4733.077049975222;6884.586924784328;6995.405390541861;6997.440204783503;7012.263712310134;7015.123109611299;6751.86496270062;6789.15135608049;6793.218779840382;6796.048553202457;6800.93199068003;6697.598144111369;6764.120664313607;6774.627395493295;6774.898376524257;6781.525293229427;6485.189351331083;6619;6632.90050649231;6640.867182656417;6646.966765166143;6763.492738044764;6774.356436138559;6797.524173308018;6838.418734407631;6842.828929276808;6613.173353330833;6628.370304821035;6629.502787290876;6649.401553860176;6663.400293973566 07:37:05 INFO - PROCESS | 26112 | |5;yui.html;720.808985618811;773.6905237904838;807.4468988742708;825.9091499935009;829.5852073963018;13528.729425411486;13662.385192666328;13701.3834377453;13750.518731844388;13791.793123103162;12312.63062108136;12414.627561173156;13539.796903046463;13689.383977721001;13792.862071379282;792.7146227358146;794.1581923161467;798.6925033861976;800.2517646000994;800.7277525641281;809.3727361294984;814.0475643497093;814.5072231300067;820.8071103290722;824.1470078468786;844.7212419901449;846.4794151596785;850.1795767084793;851.2594043182409;855.6577369052367;838.1409055717938;839.2698352433391;839.8530257204965;849.3205435651485;856.5931182688236;623.4513628007325;623.6351734235433;624.1760875644152;628.7547856335987;633.3065293503606;12686.429110690042;12767.808482872764;12877.871221287762;12955.417006234742;13892.888568914463;11974.820377694341;12014.579489717906;12504.937475312565;12540.122191446602;12712.173708708904;10475.79048419035;10558.736031599195;10588.735281618021;10589.523471443803;10664.306820056672;3577.105723569108;3624.855005799765;3627.6009638939695;3630.8184590770356;3663.19409729859;45154.54845451536;45932;46137;46188.5381146191;46232.53767462316;10053.195744340435;10064.949675251577;10090.545925433225;10133.543990520444;10305.587776489007;17286.654266914844;17349.566260843327;17392.739108913378;17434.825651743322;17511.12444377776;7280;7354.742584009534;7370.078740157481;7498.887516687254;7540.962295188599;4311.482622085307;4329.545397733255;4340.370646256275;4344.826206951687;4490.371348011281;3063.5098384258413;3081.4299354619466;3096.489079301935;3107.5804766356255;3113.081640915935;556.9108942569251;569.1292322746204;569.831899589622;570.7973669347405;575.2492996639343;520.731823111098;552.9142982837667;595.4551585299489;654.9083128361938;685.4105469296401;8037.919620803717;8051.51690898548;8224.177582241848;8227.300679442315;8344.249017588447;628.6196850905228;638.5083485715973;660.8645227728305;664.6104865187601;679.7722762874492;3498.3353162898966;3598.334308153;3633.0554055945645;3747.569029561581;4317.762523061262;50023.74988125109;51954;55185.72407137939;56686.14970775442;58679;48535.51464485381;49560;49624.751876240385;51844.22233666498;51982;42310.36534451986;42723.94122558352;48792.26811597829;51036.979260414584;51806;7992.720254791287;8220.794480137805;8462.449940753831;8529.87205191935;8574.185452382013;37107.443388348656;37575.24849503049;38329.6167038326;38451;38640.42039369355;42904;47744.7612761934;47749.283760742925;47900;48321.27518087161;10508.316959397614;10590.258681892194;10871.67384978452;11272.887271127183;11320.943395282971;11916.16586838913;12010.63968080959;12144.514219431478;12190.695232619255;12618.747625047265;10630.362178269328;10836.566537338418;10904.890951090387;11119.944400277947;11204.991938854642;10996.945015274872;11521;11686.123540734308;11751.412429378326;11961.760764784829;10443.216758742972;10793.02862742357;10854.18593605467;10883.23817332779;11068.225224234226;9461.337706360764;9814.803703926023;9884.30809843304;9892.307538472525;9910.30627856043;8878.334124940526;9282.535873206447;9391.342606017513;9396.624135034523;9421.199198068241 07:37:05 INFO - PROCESS | 26112 | __end_tp_report 07:37:05 INFO - PROCESS | 26112 | __start_cc_report 07:37:05 INFO - PROCESS | 26112 | _x_x_mozilla_cycle_collect,320 07:37:05 INFO - PROCESS | 26112 | __end_cc_report 07:37:05 INFO - PROCESS | 26112 | __startTimestamp1451403425225__endTimestamp 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - PROCESS | 26112 | ------- Summary: start ------- 07:37:05 INFO - PROCESS | 26112 | Number of tests: 6 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - PROCESS | 26112 | [#0] dojo.html Cycles:165 Average:5201.88 Median:5375.38 stddev:569.81 (10.6%) stddev-sans-first:548.09 07:37:05 INFO - PROCESS | 26112 | Values: 3138.8 3203.2 3212.5 3248.1 3250.7 5144.1 5247.2 5247.3 5253.3 5269.7 5077.8 5079.2 5161.4 5214.9 5312.9 4744.6 4792.7 4827.1 4881.4 4910.9 4529.6 4844.6 4862.9 4914.3 4932.2 4655.1 4716.7 4741.4 4793.9 4801.9 4704.3 4711.4 4724.9 4732.8 4746.1 4630.1 4690.2 4694.0 4735.3 4756.0 4991.4 5013.8 5024.7 5028.3 5064.7 5621.6 5639.3 5643.4 5648.5 5692.9 5663.8 5674.7 5676.9 5679.1 5679.3 5041.2 5147.0 5166.7 5276.6 5286.2 5830.3 5839.7 5854.6 5856.5 5861.8 5592.5 5617.7 5618.2 5634.9 5639.2 5484.8 5583.1 5585.5 5587.8 5659.5 5468.5 5494.3 5501.9 5501.9 5506.8 5523.4 5594.0 5640.5 5666.6 5710.1 4373.6 4374.2 4379.2 4380.1 4410.5 3834.9 3941.5 3944.1 3973.1 3984.7 5093.3 5120.1 5156.7 5173.0 5191.2 5618.4 5641.4 5660.1 5661.8 5667.8 5116.1 5156.1 5159.5 5166.2 5207.0 4757.4 4765.6 4780.4 4784.3 4829.4 5797.7 5801.3 5807.3 5838.6 5854.9 5388.9 5511.1 5595.5 5602.3 5613.4 5843.4 5857.2 5858.4 5864.3 5888.6 5586.8 5588.9 5591.6 5599.9 5605.0 5516.5 5618.5 5633.3 5664.0 5730.0 5395.5 5400.7 5401.9 5404.4 5425.7 5308.7 5311.0 5373.4 5375.4 5381.7 5162.9 5298.9 5355.5 5377.9 5471.5 5450.3 5471.1 5515.2 5556.3 5580.4 5334.4 5379.8 5396.1 5457.8 5515.7 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - PROCESS | 26112 | [#1] ext.html Cycles:180 Average:49076.95 Median:36212.73 stddev:93212.62 (257.4%) stddev-sans-first:93402.73 07:37:05 INFO - PROCESS | 26112 | Values: 493.0 539.5 543.8 559.0 570.5 28527.4 35769.6 36461.8 36600.6 36640.8 39199.8 39828.4 39915.4 39927.4 39964.4 8396.7 8491.1 8508.4 8556.5 8558.4 8282.9 8353.9 8369.2 8404.8 8436.0 8436.1 8464.3 8500.5 8507.1 8514.5 8254.8 8333.5 8370.1 8407.7 8421.9 8357.9 8443.4 8444.7 8458.2 8680.3 38109.0 38928.2 39067.4 39158.6 39174.2 3328.9 3419.2 3503.3 3758.7 3949.8 29348.9 29964.4 30019.5 30107.4 30126.2 3851.7 3916.5 3944.6 3981.7 4080.7 259976.0 260625.0 261013.0 261564.7 261622.0 51477.5 53356.5 58067.7 58638.0 59170.1 53521.5 53602.0 54056.7 54066.5 54126.0 15435.2 15653.7 15723.3 15817.2 15825.4 11975.4 12020.3 12073.9 12081.4 12195.0 18982.0 19348.0 20078.2 20232.5 20239.8 7482.9 7655.0 7720.7 7773.8 7831.4 934.0 934.6 1000.5 1062.9 1069.9 28697.0 29043.6 29575.4 29667.4 29861.9 1057.9 1059.1 1071.9 1086.1 1147.6 15473.1 15772.8 16584.4 16683.0 16841.2 478148.0 491488.0 492174.0 492228.0 493029.0 50253.7 50624.7 50653.2 50724.2 50798.0 1355.5 1357.9 1361.8 1362.8 1378.2 26553.7 28681.8 28699.6 28729.4 28815.9 43952.3 44356.8 44434.0 44439.0 44457.6 248700.0 250528.0 251614.0 252967.0 253393.0 31456.8 31996.0 32339.5 32429.8 32531.0 37976.6 38329.4 38558.2 38936.0 39332.2 33557.3 35347.1 35726.0 35963.6 37214.8 32847.8 32959.8 33249.7 34387.8 36922.8 35599.5 35601.5 35711.3 35798.5 35842.5 30804.5 31711.0 32773.7 32971.8 32985.8 24993.5 25332.6 25373.9 25389.5 25752.9 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - PROCESS | 26112 | [#2] jquery.html Cycles:180 Average:29118.30 Median:31876.92 stddev:89556.54 (280.9%) stddev-sans-first:89781.72 07:37:05 INFO - PROCESS | 26112 | Values: 348.9 350.9 351.5 355.7 355.9 15999.4 17122.0 17169.5 17764.7 18588.4 10396.4 10637.7 15642.2 15658.5 15777.9 5009.1 6618.5 6695.8 6705.7 6722.8 5327.6 6639.5 6643.5 6647.0 6758.3 6751.1 6756.8 6760.3 6769.4 6780.3 6348.2 6721.0 6866.9 6913.8 6915.3 6464.2 6526.4 6536.3 6539.4 6585.3 22548.4 23150.8 23169.2 23610.4 24128.2 2389.3 2415.0 2437.2 2451.1 2473.4 8758.3 13910.5 14022.3 14435.4 14730.3 1909.5 1955.2 2000.1 2001.1 2033.8 67924.7 73127.6 73425.0 73803.3 74214.6 15007.4 15543.9 15576.7 15580.0 15589.5 12641.7 13108.9 13120.7 24475.0 24588.6 7381.4 7423.2 7604.7 7646.7 7653.6 7498.1 7517.4 7612.7 7615.0 7626.9 4338.2 4344.0 4372.6 4384.3 4391.9 1822.6 1845.1 1849.7 1865.3 1885.9 872.4 1012.0 1034.8 1061.1 1075.2 16070.4 16188.9 16631.7 16726.6 16828.3 974.7 975.3 987.2 1009.8 1026.7 7177.6 9330.7 9472.4 9534.3 9694.2 527268.0 532706.0 536901.0 564632.0 582993.0 42608.4 42682.8 49331.0 81471.0 82593.0 1189.6 1197.1 1226.8 1232.4 1241.7 14998.8 15373.9 15433.4 15541.9 15561.5 31765.8 31988.0 32651.5 33539.8 34328.7 40014.8 41123.0 41267.0 41505.0 44165.3 9455.4 9486.4 9752.0 9763.6 9885.5 11405.9 11456.4 11463.3 11584.1 11689.4 13621.8 14367.8 14468.9 14661.3 14912.3 13868.7 14087.8 14159.4 14841.0 14879.3 14040.0 14088.5 14151.4 14961.0 15218.8 9486.5 9535.2 9652.0 9768.0 9790.8 14804.1 14816.3 15079.4 15203.3 15213.5 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - PROCESS | 26112 | [#3] mootools.html Cycles:180 Average:4920.10 Median:6047.06 stddev:2422.65 (40.1%) stddev-sans-first:2415.21 07:37:05 INFO - PROCESS | 26112 | Values: 1426.5 1462.8 1597.3 1734.7 1758.5 6780.0 6866.1 6892.2 6914.6 7011.2 6955.4 6964.7 7026.3 7030.5 7037.5 2155.9 2182.7 2191.0 2193.2 2201.6 2120.8 2127.3 2242.1 2243.8 2244.9 2098.9 2124.4 2132.4 2139.6 2156.1 2196.8 2203.0 2239.7 2252.3 2256.6 2185.7 2194.0 2210.3 2217.1 2224.9 6878.1 6921.5 6925.0 6957.0 6966.5 4283.1 4351.6 4372.2 4379.5 4407.8 2848.7 2865.6 2884.3 2887.5 2903.0 916.6 921.0 922.7 942.7 948.2 9269.4 9300.7 9331.5 9365.5 9373.9 3904.0 3927.6 3940.4 3960.7 4048.6 7461.9 7478.2 7491.8 7504.8 7511.7 4406.7 4422.2 4423.0 4460.4 4474.4 4058.1 4079.0 4084.1 4084.8 4099.5 3133.0 3152.1 3183.4 3185.6 3188.7 997.7 1000.0 1004.5 1005.2 1011.3 1040.2 1057.5 1062.4 1175.3 1291.5 6499.1 6509.3 6524.0 6530.9 6531.1 1187.2 1187.8 1212.1 1212.9 1219.9 5260.9 5270.6 5278.3 5304.1 5321.2 7630.1 8092.4 8121.4 8183.8 8189.7 7992.4 8023.8 8066.4 8101.4 8169.1 6612.2 6652.5 6721.4 6730.4 6802.6 6440.1 6483.7 6487.5 6494.7 6502.6 7330.1 7359.4 7483.8 7555.8 7577.8 7607.6 7628.1 7778.6 7784.0 7837.7 5977.3 5995.4 6020.0 6021.5 6050.5 6524.4 6620.7 6625.1 6646.9 6652.2 6227.4 6280.7 6337.7 6354.9 6382.5 5688.3 6170.3 6240.0 6271.6 6313.2 6370.4 6381.7 6413.4 6451.5 6479.8 5887.8 5952.0 5962.3 5969.8 5976.2 6032.8 6043.6 6056.5 6057.2 6065.1 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - PROCESS | 26112 | [#4] prototype.html Cycles:180 Average:5600.31 Median:6273.00 stddev:1703.72 (27.2%) stddev-sans-first:1662.00 07:37:05 INFO - PROCESS | 26112 | Values: 333.5 338.3 339.1 344.2 345.2 6220.4 6279.6 6316.2 6394.2 6396.7 6085.5 6292.8 6312.9 6325.1 6332.9 4837.9 4849.5 4851.8 4853.8 4853.9 4858.1 4859.4 4859.9 4866.5 4867.2 4725.2 4802.1 4804.0 4839.2 4844.3 4787.2 4805.8 4810.9 4811.7 4819.7 4170.5 4184.8 4185.0 4190.4 4191.8 5945.0 5986.9 5991.8 5992.7 5998.3 5491.6 5597.4 5600.6 5608.4 5628.9 6658.7 6679.6 6680.2 6687.6 6708.4 4623.4 4634.2 4642.0 4644.4 4649.4 6786.0 6955.1 6962.4 6995.2 6997.3 4627.6 4666.0 4668.3 4670.2 4679.4 4722.4 4733.6 4736.1 4739.5 4742.9 5526.0 5531.1 5532.6 5534.1 5534.5 6576.1 6690.4 6732.9 6741.6 6756.7 1642.6 1663.4 1679.7 1680.4 1686.3 1103.5 1113.3 1119.1 1125.9 1133.3 6129.0 6240.6 6245.5 6271.7 6274.3 6859.5 6872.5 6874.1 6874.7 6892.9 6009.9 6197.2 6230.5 6242.1 6247.4 3729.9 3738.7 3740.1 3753.2 3755.0 7143.2 7158.8 7163.1 7166.4 7166.7 6939.4 6982.4 6990.0 6990.3 6991.0 7272.5 7272.6 7290.2 7295.0 7314.6 6952.3 6989.0 7000.9 7025.8 7042.1 6723.3 6833.4 6867.7 6868.8 6932.1 7312.8 7318.1 7325.9 7331.3 7331.9 4696.3 4721.2 4726.7 4731.5 4733.1 6884.6 6995.4 6997.4 7012.3 7015.1 6751.9 6789.2 6793.2 6796.0 6800.9 6697.6 6764.1 6774.6 6774.9 6781.5 6485.2 6619.0 6632.9 6640.9 6647.0 6763.5 6774.4 6797.5 6838.4 6842.8 6613.2 6628.4 6629.5 6649.4 6663.4 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - PROCESS | 26112 | [#5] yui.html Cycles:180 Average:13726.78 Median:46162.77 stddev:15874.92 (34.4%) stddev-sans-first:15889.41 07:37:05 INFO - PROCESS | 26112 | Values: 720.8 773.7 807.4 825.9 829.6 13528.7 13662.4 13701.4 13750.5 13791.8 12312.6 12414.6 13539.8 13689.4 13792.9 792.7 794.2 798.7 800.3 800.7 809.4 814.0 814.5 820.8 824.1 844.7 846.5 850.2 851.3 855.7 838.1 839.3 839.9 849.3 856.6 623.5 623.6 624.2 628.8 633.3 12686.4 12767.8 12877.9 12955.4 13892.9 11974.8 12014.6 12504.9 12540.1 12712.2 10475.8 10558.7 10588.7 10589.5 10664.3 3577.1 3624.9 3627.6 3630.8 3663.2 45154.5 45932.0 46137.0 46188.5 46232.5 10053.2 10064.9 10090.5 10133.5 10305.6 17286.7 17349.6 17392.7 17434.8 17511.1 7280.0 7354.7 7370.1 7498.9 7541.0 4311.5 4329.5 4340.4 4344.8 4490.4 3063.5 3081.4 3096.5 3107.6 3113.1 556.9 569.1 569.8 570.8 575.2 520.7 552.9 595.5 654.9 685.4 8037.9 8051.5 8224.2 8227.3 8344.2 628.6 638.5 660.9 664.6 679.8 3498.3 3598.3 3633.1 3747.6 4317.8 50023.7 51954.0 55185.7 56686.1 58679.0 48535.5 49560.0 49624.8 51844.2 51982.0 42310.4 42723.9 48792.3 51037.0 51806.0 7992.7 8220.8 8462.4 8529.9 8574.2 37107.4 37575.2 38329.6 38451.0 38640.4 42904.0 47744.8 47749.3 47900.0 48321.3 10508.3 10590.3 10871.7 11272.9 11320.9 11916.2 12010.6 12144.5 12190.7 12618.7 10630.4 10836.6 10904.9 11119.9 11205.0 10996.9 11521.0 11686.1 11751.4 11961.8 10443.2 10793.0 10854.2 10883.2 11068.2 9461.3 9814.8 9884.3 9892.3 9910.3 8878.3 9282.5 9391.3 9396.6 9421.2 07:37:05 INFO - PROCESS | 26112 | -------- Summary: end -------- 07:37:05 INFO - PROCESS | 26112 | 07:37:05 INFO - TEST-INFO | 26112: exit 0 07:37:05 INFO - TEST-OK | dromaeo_css | took 1109986ms 07:37:05 INFO - TEST-START | kraken 07:37:05 INFO - operating with platform_type : linux_ 07:37:05 INFO - Initialising browser for kraken test... 07:37:05 INFO - TEST-INFO | started process 26375 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPPHXHS/profile http://localhost:42189/getInfo.html) 07:37:09 INFO - PROCESS | 26375 | __metrics Screen width/height:1600/1200 07:37:09 INFO - PROCESS | 26375 | colorDepth:24 07:37:09 INFO - PROCESS | 26375 | Browser inner width/height: 1024/697 07:37:09 INFO - PROCESS | 26375 | __metrics 07:37:10 INFO - PROCESS | 26375 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:37:10 INFO - TEST-INFO | 26375: exit 0 07:37:10 INFO - Browser initialized. 07:37:10 INFO - Running cycle 1/1 for kraken test... 07:37:10 INFO - TEST-INFO | started process 26497 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPPHXHS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:22 INFO - PROCESS | 26497 | RSS: Main: 149151744 07:37:22 INFO - PROCESS | 26497 | 07:37:25 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42189/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:25 INFO - PROCESS | 26497 | RSS: Main: 150622208 07:37:25 INFO - PROCESS | 26497 | 07:37:28 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42189/tests/kraken/driver.html?testName=audio-dft) 07:37:29 INFO - PROCESS | 26497 | RSS: Main: 151166976 07:37:29 INFO - PROCESS | 26497 | 07:37:31 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42189/tests/kraken/driver.html?testName=audio-fft) 07:37:32 INFO - PROCESS | 26497 | RSS: Main: 145539072 07:37:32 INFO - PROCESS | 26497 | 07:37:34 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42189/tests/kraken/driver.html?testName=audio-oscillator) 07:37:35 INFO - PROCESS | 26497 | RSS: Main: 146571264 07:37:35 INFO - PROCESS | 26497 | 07:37:37 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42189/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:37 INFO - PROCESS | 26497 | RSS: Main: 146219008 07:37:37 INFO - PROCESS | 26497 | 07:37:40 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42189/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:41 INFO - PROCESS | 26497 | RSS: Main: 147570688 07:37:41 INFO - PROCESS | 26497 | 07:37:44 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42189/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:45 INFO - PROCESS | 26497 | RSS: Main: 148852736 07:37:45 INFO - PROCESS | 26497 | 07:37:48 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42189/tests/kraken/driver.html?testName=json-parse-financial) 07:37:48 INFO - PROCESS | 26497 | RSS: Main: 146862080 07:37:48 INFO - PROCESS | 26497 | 07:37:50 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42189/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:51 INFO - PROCESS | 26497 | RSS: Main: 148004864 07:37:51 INFO - PROCESS | 26497 | 07:37:52 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42189/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:53 INFO - PROCESS | 26497 | RSS: Main: 148938752 07:37:53 INFO - PROCESS | 26497 | 07:37:55 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42189/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:56 INFO - PROCESS | 26497 | RSS: Main: 149098496 07:37:56 INFO - PROCESS | 26497 | 07:37:58 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:59 INFO - PROCESS | 26497 | RSS: Main: 147054592 07:37:59 INFO - PROCESS | 26497 | 07:38:01 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:38:02 INFO - PROCESS | 26497 | RSS: Main: 148418560 07:38:02 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | Cycle 1(1): loaded http://localhost:42189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42189/tests/kraken/driver.html?testName=ai-astar) 07:38:04 INFO - PROCESS | 26497 | RSS: Main: 149004288 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | __start_tp_report 07:38:04 INFO - PROCESS | 26497 | _x_x_mozilla_page_load 07:38:04 INFO - PROCESS | 26497 | _x_x_mozilla_page_load_details 07:38:04 INFO - PROCESS | 26497 | |i|pagename|runs| 07:38:04 INFO - PROCESS | 26497 | |0;ai-astar;111;105;112;111;111;124;112;110;111;112 07:38:04 INFO - PROCESS | 26497 | |1;audio-beat-detection;154;132;157;160;127;156;157;135;170;129 07:38:04 INFO - PROCESS | 26497 | |2;audio-dft;163;162;164;163;165;164;163;166;171;165 07:38:04 INFO - PROCESS | 26497 | |3;audio-fft;73;76;73;72;75;74;136;72;72;76 07:38:04 INFO - PROCESS | 26497 | |4;audio-oscillator;97;97;147;96;96;96;142;97;97;135 07:38:04 INFO - PROCESS | 26497 | |5;imaging-gaussian-blur;110;111;110;111;109;110;110;110;112;110 07:38:04 INFO - PROCESS | 26497 | |6;imaging-darkroom;146;147;147;146;148;146;148;147;148;146 07:38:04 INFO - PROCESS | 26497 | |7;imaging-desaturate;97;96;96;97;96;97;96;97;97;96 07:38:04 INFO - PROCESS | 26497 | |8;json-parse-financial;59;60;64;59;58;61;60;60;55;59 07:38:04 INFO - PROCESS | 26497 | |9;json-stringify-tinderbox;75;69;68;68;68;69;69;69;70;68 07:38:04 INFO - PROCESS | 26497 | |10;stanford-crypto-aes;88;94;86;85;94;96;88;87;87;88 07:38:04 INFO - PROCESS | 26497 | |11;stanford-crypto-ccm;123;136;134;128;126;120;118;128;123;123 07:38:04 INFO - PROCESS | 26497 | |12;stanford-crypto-pbkdf2;143;149;150;152;155;151;148;149;164;140 07:38:04 INFO - PROCESS | 26497 | |13;stanford-crypto-sha256-iterative;69;69;73;68;67;68;69;69;67;68 07:38:04 INFO - PROCESS | 26497 | __end_tp_report 07:38:04 INFO - PROCESS | 26497 | __start_cc_report 07:38:04 INFO - PROCESS | 26497 | _x_x_mozilla_cycle_collect,713 07:38:04 INFO - PROCESS | 26497 | __end_cc_report 07:38:04 INFO - PROCESS | 26497 | __startTimestamp1451403484435__endTimestamp 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | ------- Summary: start ------- 07:38:04 INFO - PROCESS | 26497 | Number of tests: 14 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.72 (4.2%) stddev-sans-first:5.00 07:38:04 INFO - PROCESS | 26497 | Values: 111.0 105.0 112.0 111.0 111.0 124.0 112.0 110.0 111.0 112.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:156.50 stddev:15.33 (9.8%) stddev-sans-first:16.09 07:38:04 INFO - PROCESS | 26497 | Values: 154.0 132.0 157.0 160.0 127.0 156.0 157.0 135.0 170.0 129.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.55 (1.5%) stddev-sans-first:2.64 07:38:04 INFO - PROCESS | 26497 | Values: 163.0 162.0 164.0 163.0 165.0 164.0 163.0 166.0 171.0 165.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#3] audio-fft Cycles:10 Average:79.90 Median:73.50 stddev:19.77 (26.9%) stddev-sans-first:20.81 07:38:04 INFO - PROCESS | 26497 | Values: 73.0 76.0 73.0 72.0 75.0 74.0 136.0 72.0 72.0 76.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.50 stddev:21.81 (22.6%) stddev-sans-first:22.62 07:38:04 INFO - PROCESS | 26497 | Values: 97.0 97.0 147.0 96.0 96.0 96.0 142.0 97.0 97.0 135.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 07:38:04 INFO - PROCESS | 26497 | Values: 110.0 111.0 110.0 111.0 109.0 110.0 110.0 110.0 112.0 110.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 07:38:04 INFO - PROCESS | 26497 | Values: 146.0 147.0 147.0 146.0 148.0 146.0 148.0 147.0 148.0 146.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:38:04 INFO - PROCESS | 26497 | Values: 97.0 96.0 96.0 97.0 96.0 97.0 96.0 97.0 97.0 96.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:60.00 stddev:2.27 (3.8%) stddev-sans-first:2.40 07:38:04 INFO - PROCESS | 26497 | Values: 59.0 60.0 64.0 59.0 58.0 61.0 60.0 60.0 55.0 59.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:2.11 (3.1%) stddev-sans-first:0.71 07:38:04 INFO - PROCESS | 26497 | Values: 75.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 70.0 68.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:88.00 stddev:3.86 (4.4%) stddev-sans-first:4.07 07:38:04 INFO - PROCESS | 26497 | Values: 88.0 94.0 86.0 85.0 94.0 96.0 88.0 87.0 87.0 88.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:127.00 stddev:5.76 (4.5%) stddev-sans-first:6.02 07:38:04 INFO - PROCESS | 26497 | Values: 123.0 136.0 134.0 128.0 126.0 120.0 118.0 128.0 123.0 123.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:150.50 stddev:6.51 (4.3%) stddev-sans-first:6.37 07:38:04 INFO - PROCESS | 26497 | Values: 143.0 149.0 150.0 152.0 155.0 151.0 148.0 149.0 164.0 140.0 07:38:04 INFO - PROCESS | 26497 | 07:38:04 INFO - PROCESS | 26497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 07:38:04 INFO - PROCESS | 26497 | Values: 69.0 69.0 73.0 68.0 67.0 68.0 69.0 69.0 67.0 68.0 07:38:04 INFO - PROCESS | 26497 | -------- Summary: end -------- 07:38:04 INFO - PROCESS | 26497 | 07:38:05 INFO - TEST-INFO | 26497: exit 0 07:38:05 INFO - TEST-OK | kraken | took 59432ms 07:38:05 INFO - TEST-START | v8_7 07:38:05 INFO - operating with platform_type : linux_ 07:38:05 INFO - Initialising browser for v8_7 test... 07:38:05 INFO - TEST-INFO | started process 26783 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgF28nQ/profile http://localhost:42189/getInfo.html) 07:38:09 INFO - PROCESS | 26783 | __metrics Screen width/height:1600/1200 07:38:09 INFO - PROCESS | 26783 | colorDepth:24 07:38:09 INFO - PROCESS | 26783 | Browser inner width/height: 1024/697 07:38:09 INFO - PROCESS | 26783 | __metrics 07:38:09 INFO - PROCESS | 26783 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:38:10 INFO - TEST-INFO | 26783: exit 0 07:38:10 INFO - Browser initialized. 07:38:10 INFO - Running cycle 1/1 for v8_7 test... 07:38:10 INFO - TEST-INFO | started process 26903 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgF28nQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:22 INFO - PROCESS | 26903 | RSS: Main: 149348352 07:38:22 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | Cycle 1(1): loaded http://localhost:42189/tests/v8_7/run.html (next: http://localhost:42189/tests/v8_7/run.html) 07:38:43 INFO - PROCESS | 26903 | RSS: Main: 146350080 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | __start_tp_report 07:38:43 INFO - PROCESS | 26903 | _x_x_mozilla_page_load 07:38:43 INFO - PROCESS | 26903 | _x_x_mozilla_page_load_details 07:38:43 INFO - PROCESS | 26903 | |i|pagename|runs| 07:38:43 INFO - PROCESS | 26903 | |0;Richards;169.83695652173913 07:38:43 INFO - PROCESS | 26903 | |1;DeltaBlue;196.7729240456513 07:38:43 INFO - PROCESS | 26903 | |2;Encrypt;283.36639274582035 07:38:43 INFO - PROCESS | 26903 | |3;Decrypt;5213.541666666667 07:38:43 INFO - PROCESS | 26903 | |4;RayTrace;1072.961373390558 07:38:43 INFO - PROCESS | 26903 | |5;Earley;712.9629629629629 07:38:43 INFO - PROCESS | 26903 | |6;Boyer;12231.707317073171 07:38:43 INFO - PROCESS | 26903 | |7;RegExp;25175 07:38:43 INFO - PROCESS | 26903 | |8;Splay;674.3088334457182 07:38:43 INFO - PROCESS | 26903 | |9;NavierStokes;4873.78640776699 07:38:43 INFO - PROCESS | 26903 | __end_tp_report 07:38:43 INFO - PROCESS | 26903 | __startTimestamp1451403523819__endTimestamp 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | ------- Summary: start ------- 07:38:43 INFO - PROCESS | 26903 | Number of tests: 10 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#0] Richards Cycles:1 Average:169.84 Median:169.84 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 169.8 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#1] DeltaBlue Cycles:1 Average:196.77 Median:196.77 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 196.8 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#2] Encrypt Cycles:1 Average:283.37 Median:283.37 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 283.4 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 5213.5 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 1073.0 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#5] Earley Cycles:1 Average:712.96 Median:712.96 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 713.0 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 12231.7 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#7] RegExp Cycles:1 Average:25175.00 Median:25175.00 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 25175.0 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#8] Splay Cycles:1 Average:674.31 Median:674.31 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 674.3 07:38:43 INFO - PROCESS | 26903 | 07:38:43 INFO - PROCESS | 26903 | [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 07:38:43 INFO - PROCESS | 26903 | Values: 4873.8 07:38:43 INFO - PROCESS | 26903 | -------- Summary: end -------- 07:38:43 INFO - PROCESS | 26903 | 07:38:44 INFO - TEST-INFO | 26903: exit 0 07:38:44 INFO - TEST-OK | v8_7 | took 39346ms 07:38:44 INFO - SUITE-END | took 1208s 07:38:44 INFO - Completed test suite (00:20:08) 07:38:44 INFO - Working with test: dromaeo_css 07:38:44 INFO - Generating results file: dromaeo_css 07:38:44 INFO - Working with test: kraken 07:38:44 INFO - Generating results file: kraken 07:38:44 INFO - javascript benchmark 07:38:44 INFO - Working with test: v8_7 07:38:44 INFO - Generating results file: v8_7 07:38:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:38:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:38:44 INFO - process_Request line: dromaeo_css 6970.74 graph.html#tests=[[72,1,43]] 07:38:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:38:44 INFO - process_Request line: kraken 1530.60 graph.html#tests=[[232,1,43]] 07:38:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:38:44 INFO - process_Request line: v8_7 20952.75 graph.html#tests=[[230,1,43]] 07:38:44 INFO - RETURN: dromaeo_css: 6970.74 07:38:44 INFO - RETURN: kraken: 1530.60 07:38:44 INFO - RETURN: v8_7: 20952.75 07:38:44 INFO - javascript benchmark 07:38:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3138.843057847108, 3203.1992001999515, 3212.486002239642, 3248.074298824835, 3250.7074363307297, 5144.125498665227, 5247.239150323206, 5247.317848679671, 5253.264542963988, 5269.73651317434, 5077.822276220333, 5079.161938280179, 5161.380634323877, 5214.921776173351, 5312.92030619541, 4744.64415168862, 4792.712437253767, 4827.058723548909, 4881.438634557018, 4910.926336104962, 4529.569690879362, 4844.636652251095, 4862.902741945159, 4914.336564563774, 4932.161532539477, 4655.068986202756, 4716.740579268139, 4741.359916411292, 4793.880152996168, 4801.855944321676, 4704.317873908264, 4711.387519622462, 4724.881877953045, 4732.834350797705, 4746.050789842011, 4630.097131059411, 4690.226112691402, 4694.0, 4735.266033764772, 4756.0, 4991.351124353847, 5013.824516141917, 5024.673396229234, 5028.270900719412, 5064.746762661889, 5621.578381621394, 5639.323281206241, 5643.435656434365, 5648.4633959773755, 5692.886142277172, 5663.801766938137, 5674.659520428788, 5676.886462270772, 5679.119736440858, 5679.261695979496, 5041.168207245837, 5146.974265128651, 5166.715830629276, 5276.630635855492, 5286.207068939651, 5830.271216097988, 5839.708014599253, 5854.648721076749, 5856.531477481792, 5861.765529378862, 5592.468715472024, 5617.691026993472, 5618.185363122325, 5634.859128521738, 5639.238702775155, 5484.780608775604, 5583.134614134816, 5585.497305242467, 5587.776488940478, 5659.462351076641, 5468.453154684579, 5494.313210848644, 5501.862453438696, 5501.9174712379345, 5506.752196151183, 5523.447655234525, 5594.049011668027, 5640.464155905182, 5666.631668941505, 5710.057840456278, 4373.6282415994365, 4374.168907907488, 4379.233634114017, 4380.14587155508, 4410.514843367227, 3834.884953451401, 3941.507311586052, 3944.092858642471, 3973.145773658677, 3984.7210695251056, 5093.261477085802, 5120.052790233819, 5156.690598564023, 5173.0, 5191.22131680251, 5618.381977982419, 5641.379448260688, 5660.094384898396, 5661.801836935688, 5667.829965101054, 5116.104681680766, 5156.071907056766, 5159.535641792257, 5166.225066240094, 5206.97396513015, 4757.35775670287, 4765.642576806753, 4780.402449693788, 4784.258439941815, 4829.372181616367, 5797.652140871562, 5801.274840644919, 5807.303123625192, 5838.649681019152, 5854.912176317359, 5388.919166212589, 5511.145772405283, 5595.468430499096, 5602.2717046783655, 5613.410591887956, 5843.444872737083, 5857.150713146655, 5858.355580886185, 5864.296284445893, 5888.617239879394, 5586.804461843816, 5588.944110558842, 5591.580631452739, 5599.944000559943, 5605.019121653613, 5516.475934786189, 5618.52242559387, 5633.295838020247, 5663.9716801415725, 5730.0, 5395.514403703685, 5400.675959442446, 5401.864953376197, 5404.378496472956, 5425.728713564385, 5308.708021058725, 5310.964361949537, 5373.382061062872, 5375.381831089318, 5381.73091345439, 5162.8967420652125, 5298.867528311823, 5355.518003379714, 5377.892442151213, 5471.50756431923, 5450.291462109901, 5471.069918113851, 5515.172724091419, 5556.305461817273, 5580.358258800127, 5334.359876814652, 5379.784808607768, 5396.109641909041, 5457.836264912059, 5515.669059856261], "unit": "score", "name": "dojo.html", "value": 5166.263505269918}, {"lowerIsBetter": false, "replicates": [492.9507049295071, 539.4928766959056, 543.793358523761, 559.0105513241563, 570.4723131103731, 28527.429451410986, 35769.642303576955, 36461.817690911506, 36600.63399366012, 36640.81679591602, 39199.80400097996, 39828.402573961415, 39915.40126898099, 39927.401088983686, 39964.40053399194, 8396.748097557067, 8491.108433614474, 8508.446950948199, 8556.5293908835, 8558.400911936167, 8282.875756863652, 8353.913991181138, 8369.246767790897, 8404.831903361928, 8436.0, 8436.072032076467, 8464.280536154403, 8500.489970601784, 8507.149285071506, 8514.531700756455, 8254.752357429286, 8333.541655208961, 8370.079291277954, 8407.663693452285, 8421.915780842175, 8357.874631880526, 8443.408961372706, 8444.746657600283, 8458.238758511763, 8680.262177714902, 38109.0, 38928.22143557142, 39067.41398879019, 39158.60841391578, 39174.21651566981, 3328.8502017409273, 3419.196488825124, 3503.2993401319836, 3758.68051215647, 3949.822257998397, 29348.853255733797, 29964.400711985858, 30019.5497067542, 30107.397852043054, 30126.24684382886, 3851.73037887348, 3916.4712763777097, 3944.6252606002386, 3981.7212795104356, 4080.6531444827224, 259976.0, 260625.0, 261013.0, 261564.6921765398, 261622.0, 51477.48522514802, 53356.466435335926, 58067.70966145142, 58638.0, 59170.11244831331, 53521.46478535243, 53602.0, 54056.72971635117, 54066.45933540693, 54126.0, 15435.151066691215, 15653.686926261411, 15723.292451839694, 15817.209139542976, 15825.366985320457, 11975.401229938469, 12020.278783273032, 12073.939630301968, 12081.395930203455, 12195.024398048135, 18982.0, 19348.032598370308, 20078.19687212495, 20232.494187645425, 20239.79760202379, 7482.925170748223, 7654.961725191339, 7720.691172353043, 7773.766786996286, 7831.412644051719, 934.0472717827778, 934.6495064350869, 1000.5047501486665, 1062.9202809789142, 1069.893010698924, 28697.0, 29043.56434653482, 29575.408491830043, 29667.40665186684, 29861.85069074684, 1057.9047885690325, 1059.0944742245424, 1071.8713754349371, 1086.1093902999623, 1147.5983405807901, 15473.148976806384, 15772.842271577367, 16584.419545315857, 16682.999020058836, 16841.242144103544, 478148.0, 491488.0, 492174.0, 492228.0, 493029.0, 50253.74873125684, 50624.74687626538, 50653.240201397006, 50724.23913641298, 50798.0, 1355.4645914863574, 1357.911735737174, 1361.8161548191263, 1362.7887677410017, 1378.1593228130832, 26553.734462655128, 28681.83769858305, 28699.569506457836, 28729.42541149207, 28815.855920720263, 43952.34071488994, 44356.778216110004, 44434.0, 44439.0, 44457.555424445345, 248700.0, 250528.0, 251614.0, 252967.0, 253393.0, 31456.842715786275, 31996.0, 32339.514907275938, 32429.837850810596, 32531.0, 37976.620233798414, 38329.4250586247, 38558.228835423695, 38936.0, 39332.2133557333, 33557.3288534223, 35347.11632209215, 35726.0, 35963.64036359708, 37214.81392593128, 32847.83576082104, 32959.83520082384, 33249.66750332466, 34387.82806085954, 36922.8153859229, 35599.46600800938, 35601.46597800983, 35711.285774283846, 35798.46302305415, 35842.4623630651, 30804.53793193059, 31711.0, 32773.67226327706, 32971.835140825104, 32985.83507082449, 24993.500129996934, 25332.60670663131, 25373.873130634227, 25389.51858925058, 25752.871235643703], "unit": "score", "name": "ext.html", "value": 18322.720571358386}, {"lowerIsBetter": false, "replicates": [348.9357459747769, 350.8964855367667, 351.47805508819397, 355.69943397828825, 355.87366484897876, 15999.440019599317, 17122.0, 17169.484915452525, 17764.733528997076, 18588.442346729604, 10396.376217426941, 10637.680869573906, 15642.217889105556, 15658.451954181606, 15777.92111039446, 5009.098362294776, 6618.536702430832, 6695.765648202314, 6705.664716764167, 6722.798316050502, 5327.627066105355, 6639.535232533724, 6643.468522518211, 6646.9667651661675, 6758.290379510155, 6751.054852320679, 6756.8310792230095, 6760.256371799098, 6769.424598909099, 6780.288069752679, 6348.174737284146, 6721.0, 6866.931330686704, 6913.827154321132, 6915.343042410963, 6464.191976003, 6526.379993900572, 6536.313687062885, 6539.44414724749, 6585.341465853424, 22548.43628909274, 23150.76849231503, 23169.189078382176, 23610.409739756473, 24128.155514556907, 2389.342930694073, 2415.0098459631467, 2437.24445421918, 2451.105346548497, 2473.3816545863533, 8758.255548278405, 13910.51313204033, 14022.298885055809, 14435.35040923161, 14730.263486825615, 1909.4653497020718, 1955.2081407030175, 2000.1499362770764, 2001.129508663736, 2033.8169564739096, 67924.66037669829, 73127.63436182839, 73425.0, 73803.26196738018, 74214.62892685556, 15007.399704011717, 15543.922280388526, 15576.688466230611, 15580.0, 15589.454369097028, 12641.747165056648, 13108.934455327662, 13120.671983200305, 24475.0, 24588.6311705321, 7381.446391520657, 7423.183449820515, 7604.657790399446, 7646.655900484491, 7653.57905315213, 7498.137714162941, 7517.361024312994, 7612.657430415645, 7615.048118985127, 7626.885596716053, 4338.219120558267, 4343.978280108579, 4372.562743725602, 4384.298512238027, 4391.890202744893, 1822.571695651521, 1845.0571338714728, 1849.6670599292256, 1865.2632210276865, 1885.8585606079598, 872.4154816273112, 1012.0335079998583, 1034.7930413917247, 1061.0874647802884, 1075.2419544221304, 16070.43753468623, 16188.919055404647, 16631.671565980774, 16726.581835453966, 16828.326866925432, 974.6637410093506, 975.2734213011211, 987.1609132237684, 1009.7828966772179, 1026.6560702164709, 7177.605231712306, 9330.720078397659, 9472.384295020802, 9534.28492863038, 9694.22446204302, 527268.0, 532706.0, 536901.0, 564632.0, 582993.0, 42608.360874586906, 42682.78658606687, 49331.013379732205, 81471.0, 82593.0, 1189.5539172810197, 1197.060307658484, 1226.8405107335989, 1232.383808095952, 1241.6647505173553, 14998.775018374516, 15373.923130384277, 15433.382664693736, 15541.91206615526, 15561.45534906318, 31765.841170794, 31988.0, 32651.510227346134, 33539.83230083834, 34328.656713432545, 40014.79992600018, 41123.0, 41267.0, 41505.0, 44165.337519936584, 9455.385399948982, 9486.383385079947, 9751.951240243754, 9763.609455621696, 9885.456299903575, 11405.885941140483, 11456.369899655265, 11463.31220126795, 11584.07327413788, 11689.357085360387, 13621.79567306511, 14367.784483232968, 14468.927655362077, 14661.340239689027, 14912.328945197276, 13868.653283667989, 14087.788683169965, 14159.362828672529, 14841.0, 14879.256037198313, 14040.017198796395, 14088.506902258781, 14151.363188656329, 14961.0, 15218.847811522186, 9486.478243696387, 9535.189508891544, 9652.0, 9767.951160244438, 9790.80418391614, 14804.111753294406, 14816.333265002886, 15079.396824126912, 15203.31585078652, 15213.467528636445], "unit": "score", "name": "jquery.html", "value": 9333.432642245667}, {"lowerIsBetter": false, "replicates": [1426.4579459805273, 1462.765957446808, 1597.2892063031948, 1734.7397890316442, 1758.5076178669976, 6779.9661001694985, 6866.073080134181, 6892.2418533961345, 6914.619695916723, 7011.158660960692, 6955.374016338541, 6964.6865891034895, 7026.262242464544, 7030.472714546404, 7037.472189585776, 2155.892205389728, 2182.7053347798, 2191.0359441845535, 2193.1556350804976, 2201.5927053495075, 2120.756113047004, 2127.2660931978444, 2242.0807468937737, 2243.764404737495, 2244.932652020442, 2098.9475263118393, 2124.362691192644, 2132.3816093332916, 2139.6255655260343, 2156.0728886578763, 2196.791304826047, 2203.0, 2239.675247089163, 2252.324302709189, 2256.638937769957, 2185.715856938604, 2193.9780602193932, 2210.292706333974, 2217.124235926816, 2224.877631730254, 6878.071460352839, 6921.515493915428, 6925.030495730602, 6957.0, 6966.477514186406, 4283.1433713257475, 4351.586599273064, 4372.1692878353015, 4379.5182529921685, 4407.757573333465, 2848.7151284871557, 2865.584490248923, 2884.293348129722, 2887.5235586128265, 2902.983955615539, 916.5783739479847, 920.9953950230273, 922.7370199493113, 942.6700654770775, 948.1798244518511, 9269.351145419823, 9300.674476393362, 9331.486768227745, 9365.531723413802, 9373.859392109123, 3904.0, 3927.646511813893, 3940.4286378474962, 3960.7227494075714, 4048.5951404859866, 7461.925380746232, 7478.2147874473485, 7491.812704682317, 7504.812379690442, 7511.661975211128, 4406.735595864195, 4422.20400327944, 4423.0, 4460.3532487789735, 4474.373587697725, 4058.0869304406274, 4079.02103495159, 4084.101497670508, 4084.7549147051272, 4099.528554216244, 3132.9530057049164, 3152.085895090444, 3183.4110689522513, 3185.61772587291, 3188.713015828587, 997.6757553795046, 1000.0399616368222, 1004.5379125602159, 1005.1757558801712, 1011.2769369900557, 1040.245821779219, 1057.4606950455322, 1062.4103622489438, 1175.26545908807, 1291.5285920639087, 6499.05763664266, 6509.349065093547, 6523.967380163069, 6530.934690653033, 6531.11829902957, 1187.2045729361348, 1187.7624475105013, 1212.1030437476204, 1212.8665846756849, 1219.9264647110485, 5260.894782104337, 5270.60470464709, 5278.340207474066, 5304.071787437183, 5321.201819727072, 7630.122535908442, 8092.352611791042, 8121.431499795076, 8183.754487365389, 8189.672413103528, 7992.440529163019, 8023.799405014921, 8066.354691624656, 8101.392395570356, 8169.142240064826, 6612.173478315211, 6652.501062420338, 6721.428678562279, 6730.360615741497, 6802.591844489248, 6440.13058237132, 6483.708233129426, 6487.545871789118, 6494.7077381517, 6502.60984340941, 7330.083739532559, 7359.411247100112, 7483.775486735407, 7555.848883022419, 7577.848443031219, 7607.581583012766, 7628.122765881994, 7778.649960751666, 7783.961080194563, 7837.6864925404625, 5977.3126090500145, 5995.370486098896, 6020.0, 6021.488173505301, 6050.485708714808, 6524.412802847766, 6620.66896655175, 6625.138731964814, 6646.867062658816, 6652.168478940132, 6227.377262273736, 6280.7487700491465, 6337.683115844282, 6354.936450635434, 6382.457491113308, 5688.288963879515, 6170.259568851767, 6240.0, 6271.560990730605, 6313.179286692701, 6370.394812492806, 6381.680915954091, 6413.422791948747, 6451.548391612542, 6479.8056058318325, 5887.8233652990475, 5951.970240148771, 5962.314333851489, 5969.820905372846, 5976.19321391624, 6032.788852390146, 6043.637381757108, 6056.5154787616, 6057.151998720271, 6065.120557519223], "unit": "score", "name": "mootools.html", "value": 4118.632474592496}, {"lowerIsBetter": false, "replicates": [333.4747772258692, 338.34530184093796, 339.06249220904186, 344.1980186166232, 345.16642308824174, 6220.409061139185, 6279.623222606635, 6316.242050953886, 6394.168758061445, 6396.712147953342, 6085.452309292163, 6292.811215663526, 6312.873742525147, 6325.146105275787, 6332.936670633292, 4837.927431088537, 4849.515048495157, 4851.781669824866, 4853.757312134397, 4853.927191092136, 4858.125537403266, 4859.441164266102, 4859.878503037417, 4866.51334866514, 4867.245576935581, 4725.243960966246, 4802.111609352281, 4804.015176888747, 4839.225723884179, 4844.2733589961435, 4787.234042553192, 4805.783739731721, 4810.879728006793, 4811.735354555498, 4819.686720363183, 4170.457840480748, 4184.790760461995, 4184.979075104605, 4190.371444283352, 4191.832326706958, 5945.0, 5986.940130598682, 5991.820245392645, 5992.700364981733, 5998.28020637522, 5491.560675145979, 5597.384287728347, 5600.5799565032785, 5608.383077861432, 5628.85927851807, 6658.700358483879, 6679.632620205887, 6680.198376194888, 6687.565308254948, 6708.396244338033, 4623.352730617683, 4634.165850146972, 4641.976790116061, 4644.396228490308, 4649.418822647169, 6786.0, 6955.130608673916, 6962.408195303406, 6995.230524642286, 6997.265287144827, 4627.629789616823, 4666.020135771526, 4668.276417155346, 4670.159371313196, 4679.368285281512, 4722.433308003062, 4733.621310295168, 4736.1238170937795, 4739.454962679267, 4742.857714268508, 5526.032944234743, 5531.115021596525, 5532.585056120807, 5534.142207957773, 5534.501894829485, 6576.145101136917, 6690.431313338323, 6732.865342693217, 6741.561798483083, 6756.662166891636, 1642.6304081581789, 1663.3679201903442, 1679.6724638695582, 1680.4118558504426, 1686.3254698120604, 1103.5475455063386, 1113.2930589075995, 1119.076761671608, 1125.926814757038, 1133.2973556394923, 6129.049997250433, 6240.594361366497, 6245.532299909518, 6271.655058971709, 6274.341194174637, 6859.519833611699, 6872.450203983769, 6874.072000279998, 6874.6562671867205, 6892.862142757117, 6009.879802403927, 6197.163382943335, 6230.532710046765, 6242.09489624002, 6247.406496382836, 3729.850805967731, 3738.6635202831876, 3740.0836794985403, 3753.174301653632, 3755.0, 7143.178534468602, 7158.821029474305, 7163.068801055933, 7166.426685865118, 7166.713331466787, 6939.444844412435, 6982.406495447843, 6990.0, 6990.266022067712, 6990.965045174741, 7272.454565907472, 7272.563646181352, 7290.198078211392, 7294.96352518234, 7314.561126332437, 6952.304769523007, 6989.0, 7000.859982800417, 7025.789226323219, 7042.084529011196, 6723.26044135135, 6833.384995350442, 6867.725290988505, 6868.793936181923, 6932.0988271524375, 7312.780616581511, 7318.085239345082, 7325.890111648223, 7331.303526165006, 7331.936869154049, 4696.31903374002, 4721.173794586002, 4726.669133160645, 4731.526847315241, 4733.077049975222, 6884.586924784328, 6995.405390541861, 6997.440204783503, 7012.263712310134, 7015.123109611299, 6751.86496270062, 6789.15135608049, 6793.218779840382, 6796.048553202457, 6800.93199068003, 6697.598144111369, 6764.120664313607, 6774.627395493295, 6774.898376524257, 6781.525293229427, 6485.189351331083, 6619.0, 6632.90050649231, 6640.867182656417, 6646.966765166143, 6763.492738044764, 6774.356436138559, 6797.524173308018, 6838.418734407631, 6842.828929276808, 6613.173353330833, 6628.370304821035, 6629.502787290876, 6649.401553860176, 6663.400293973566], "unit": "score", "name": "prototype.html", "value": 5039.78599545031}, {"lowerIsBetter": false, "replicates": [720.808985618811, 773.6905237904838, 807.4468988742708, 825.9091499935009, 829.5852073963018, 13528.729425411486, 13662.385192666328, 13701.3834377453, 13750.518731844388, 13791.793123103162, 12312.63062108136, 12414.627561173156, 13539.796903046463, 13689.383977721001, 13792.862071379282, 792.7146227358146, 794.1581923161467, 798.6925033861976, 800.2517646000994, 800.7277525641281, 809.3727361294984, 814.0475643497093, 814.5072231300067, 820.8071103290722, 824.1470078468786, 844.7212419901449, 846.4794151596785, 850.1795767084793, 851.2594043182409, 855.6577369052367, 838.1409055717938, 839.2698352433391, 839.8530257204965, 849.3205435651485, 856.5931182688236, 623.4513628007325, 623.6351734235433, 624.1760875644152, 628.7547856335987, 633.3065293503606, 12686.429110690042, 12767.808482872764, 12877.871221287762, 12955.417006234742, 13892.888568914463, 11974.820377694341, 12014.579489717906, 12504.937475312565, 12540.122191446602, 12712.173708708904, 10475.79048419035, 10558.736031599195, 10588.735281618021, 10589.523471443803, 10664.306820056672, 3577.105723569108, 3624.855005799765, 3627.6009638939695, 3630.8184590770356, 3663.19409729859, 45154.54845451536, 45932.0, 46137.0, 46188.5381146191, 46232.53767462316, 10053.195744340435, 10064.949675251577, 10090.545925433225, 10133.543990520444, 10305.587776489007, 17286.654266914844, 17349.566260843327, 17392.739108913378, 17434.825651743322, 17511.12444377776, 7280.0, 7354.742584009534, 7370.078740157481, 7498.887516687254, 7540.962295188599, 4311.482622085307, 4329.545397733255, 4340.370646256275, 4344.826206951687, 4490.371348011281, 3063.5098384258413, 3081.4299354619466, 3096.489079301935, 3107.5804766356255, 3113.081640915935, 556.9108942569251, 569.1292322746204, 569.831899589622, 570.7973669347405, 575.2492996639343, 520.731823111098, 552.9142982837667, 595.4551585299489, 654.9083128361938, 685.4105469296401, 8037.919620803717, 8051.51690898548, 8224.177582241848, 8227.300679442315, 8344.249017588447, 628.6196850905228, 638.5083485715973, 660.8645227728305, 664.6104865187601, 679.7722762874492, 3498.3353162898966, 3598.334308153, 3633.0554055945645, 3747.569029561581, 4317.762523061262, 50023.74988125109, 51954.0, 55185.72407137939, 56686.14970775442, 58679.0, 48535.51464485381, 49560.0, 49624.751876240385, 51844.22233666498, 51982.0, 42310.36534451986, 42723.94122558352, 48792.26811597829, 51036.979260414584, 51806.0, 7992.720254791287, 8220.794480137805, 8462.449940753831, 8529.87205191935, 8574.185452382013, 37107.443388348656, 37575.24849503049, 38329.6167038326, 38451.0, 38640.42039369355, 42904.0, 47744.7612761934, 47749.283760742925, 47900.0, 48321.27518087161, 10508.316959397614, 10590.258681892194, 10871.67384978452, 11272.887271127183, 11320.943395282971, 11916.16586838913, 12010.63968080959, 12144.514219431478, 12190.695232619255, 12618.747625047265, 10630.362178269328, 10836.566537338418, 10904.890951090387, 11119.944400277947, 11204.991938854642, 10996.945015274872, 11521.0, 11686.123540734308, 11751.412429378326, 11961.760764784829, 10443.216758742972, 10793.02862742357, 10854.18593605467, 10883.23817332779, 11068.225224234226, 9461.337706360764, 9814.803703926023, 9884.30809843304, 9892.307538472525, 9910.30627856043, 8878.334124940526, 9282.535873206447, 9391.342606017513, 9396.624135034523, 9421.199198068241], "unit": "score", "name": "yui.html", "value": 6255.481089054246}], "name": "dromaeo_css", "value": 6970.745271407227}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 111.0, 111.0, 124.0, 112.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 157.0, 160.0, 127.0, 156.0, 157.0, 135.0, 170.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 164.0, 163.0, 165.0, 164.0, 163.0, 166.0, 171.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 73.0, 72.0, 75.0, 74.0, 136.0, 72.0, 72.0, 76.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 147.0, 96.0, 96.0, 96.0, 142.0, 97.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 112.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 148.0, 146.0, 148.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 64.0, 59.0, 58.0, 61.0, 60.0, 60.0, 55.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [75.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [88.0, 94.0, 86.0, 85.0, 94.0, 96.0, 88.0, 87.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [123.0, 136.0, 134.0, 128.0, 126.0, 120.0, 118.0, 128.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [143.0, 149.0, 150.0, 152.0, 155.0, 151.0, 148.0, 149.0, 164.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 73.0, 68.0, 67.0, 68.0, 69.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1530.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.83695652173913], "unit": "score", "name": "Richards", "value": 207.85817599999996}, {"lowerIsBetter": false, "replicates": [196.7729240456513], "unit": "score", "name": "DeltaBlue", "value": 336.0116760000001}, {"lowerIsBetter": false, "replicates": [283.36639274582035], "unit": "score", "name": "Encrypt", "value": 939.3527489999996}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [712.9629629629629], "unit": "score", "name": "Earley", "value": 934.7792727272724}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25175.0], "unit": "score", "name": "RegExp", "value": 36.186097318768596}, {"lowerIsBetter": false, "replicates": [674.3088334457182], "unit": "score", "name": "Splay", "value": 120.85115299999997}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 20952.750131630655}]} 07:38:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20952.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1530.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6970.74"}}} 07:38:45 INFO - Return code: 0 07:38:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:38:45 INFO - # TBPL SUCCESS # 07:38:45 INFO - Running post-action listener: _resource_record_post_action 07:38:45 INFO - Running post-run listener: _resource_record_post_run 07:38:46 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 155648; Write bytes: 555532288; Read time: 508; Write time: 438316 07:38:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 235315200; Read time: 164; Write time: 271192 07:38:46 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 151552; Write bytes: 320217088; Read time: 344; Write time: 167124 07:38:46 INFO - Running post-run listener: _upload_blobber_files 07:38:46 INFO - Blob upload gear active. 07:38:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:38:46 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 07:38:46 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'] 07:38:46 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 07:38:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:47 INFO - (blobuploader) - INFO - Done attempting. 07:38:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:38:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:38:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:48 INFO - (blobuploader) - INFO - Done attempting. 07:38:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:38:48 INFO - Return code: 0 07:38:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:38:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:38:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7214a52633375c2ce07b60c9fcd6a1399d34eadacf3e470f2ae12c84d21cb523bf27620ad4ca3b623e92406705538ccfdb28b2ee66a42c1e7185000e2566aa74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f0107e795f827c9a9f593160799202b96b1f2fd894b36a32911c89dfb4ae4a0248aecb67b9d9eaa7c8d8c96391dc1e56d906b66fe243ce160cb796e3a9ad1cb"} 07:38:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:38:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:38:48 INFO - Contents: 07:38:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7214a52633375c2ce07b60c9fcd6a1399d34eadacf3e470f2ae12c84d21cb523bf27620ad4ca3b623e92406705538ccfdb28b2ee66a42c1e7185000e2566aa74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f0107e795f827c9a9f593160799202b96b1f2fd894b36a32911c89dfb4ae4a0248aecb67b9d9eaa7c8d8c96391dc1e56d906b66fe243ce160cb796e3a9ad1cb"} 07:38:48 INFO - Copying logs to upload dir... 07:38:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.965144 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-29 07:38:45.947672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 07:38:45.950829) ========= 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=5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7214a52633375c2ce07b60c9fcd6a1399d34eadacf3e470f2ae12c84d21cb523bf27620ad4ca3b623e92406705538ccfdb28b2ee66a42c1e7185000e2566aa74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f0107e795f827c9a9f593160799202b96b1f2fd894b36a32911c89dfb4ae4a0248aecb67b9d9eaa7c8d8c96391dc1e56d906b66fe243ce160cb796e3a9ad1cb"} build_url:https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7214a52633375c2ce07b60c9fcd6a1399d34eadacf3e470f2ae12c84d21cb523bf27620ad4ca3b623e92406705538ccfdb28b2ee66a42c1e7185000e2566aa74", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f0107e795f827c9a9f593160799202b96b1f2fd894b36a32911c89dfb4ae4a0248aecb67b9d9eaa7c8d8c96391dc1e56d906b66fe243ce160cb796e3a9ad1cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 07:38:45.981410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:38:45.981982) ========= 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=5752742a61d0f534093fa7a9000001cb-1451401947.781695-196330723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:38:46.068257) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 07:38:46.068861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 07:38:46.069460) ========= ========= Total master_lag: 0.24 =========