builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1451402244.65 results: success (0) buildid: 20151229043001 builduid: 5773e6c0f17249b9ad7c605c177a0565 revision: 9ddf0da90fb3bc1ae29966dc596013fc54a44bd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.647543) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.647913) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.648202) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005888 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.668032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.668330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.682106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.682450) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004814 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.731673) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.731936) ========= 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:24.732274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.732548) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 07:17:24-- 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% 47.5M=0s 2015-12-29 07:17:25 (47.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176208 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.923516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.923792) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015321 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.975691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:24.976402) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 07:17:25,184 truncating revision to first 12 chars 2015-12-29 07:17:25,184 Setting DEBUG logging. 2015-12-29 07:17:25,184 attempt 1/10 2015-12-29 07:17:25,184 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:25,510 unpacking tar archive at: mozilla-central-9ddf0da90fb3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616415 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:25.607265) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:25.607555) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:25.618152) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 07:17:25.618431) ========= 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:25.618834) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-29 07:17:25.619196) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:17:25 INFO - MultiFileLogger online at 20151229 07:17:25 in /builds/slave/test-pgo 07:17:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:17:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:17:25 INFO - {'append_to_log': False, 07:17:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:17:25 INFO - 'blob_upload_branch': 'Firefox', 07:17:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:17:25 INFO - 'branch': 'Firefox', 07:17:25 INFO - 'buildbot_json_path': 'buildprops.json', 07:17:25 INFO - 'config_files': ('talos/linux_config.py',), 07:17:25 INFO - 'default_actions': ('clobber', 07:17:25 INFO - 'read-buildbot-config', 07:17:25 INFO - 'download-and-extract', 07:17:25 INFO - 'populate-webroot', 07:17:25 INFO - 'create-virtualenv', 07:17:25 INFO - 'install', 07:17:25 INFO - 'run-tests'), 07:17:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:17:25 INFO - 'download_minidump_stackwalk': True, 07:17:25 INFO - 'download_symbols': 'ondemand', 07:17:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:17:25 INFO - 'tooltool.py': '/tools/tooltool.py', 07:17:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:17:25 INFO - '/tools/misc-python/virtualenv.py')}, 07:17:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:17:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:17:25 INFO - 'installer_path': 'installer.exe', 07:17:25 INFO - 'log_level': 'info', 07:17:25 INFO - 'log_name': 'talos', 07:17:25 INFO - 'log_to_console': True, 07:17:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:17:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:17:25 INFO - 'opt_config_files': (), 07:17:25 INFO - 'pip_index': False, 07:17:25 INFO - 'sps_profile': False, 07:17:25 INFO - 'sps_profile_interval': 0, 07:17:25 INFO - 'suite': 'dromaeojs', 07:17:25 INFO - 'system_bits': '32', 07:17:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:17:25 INFO - 'title': 'talos-linux64-ix-030', 07:17:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:17:25 INFO - 'use_talos_json': True, 07:17:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:17:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:17:25 INFO - 'work_dir': 'build'} 07:17:25 INFO - ##### 07:17:25 INFO - ##### Running clobber step. 07:17:25 INFO - ##### 07:17:25 INFO - Running pre-action listener: _resource_record_pre_action 07:17:25 INFO - Running main action method: clobber 07:17:25 INFO - rmtree: /builds/slave/test-pgo/build 07:17:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:17:26 INFO - Running post-action listener: _resource_record_post_action 07:17:26 INFO - ##### 07:17:26 INFO - ##### Running read-buildbot-config step. 07:17:26 INFO - ##### 07:17:26 INFO - Running pre-action listener: _resource_record_pre_action 07:17:26 INFO - Running main action method: read_buildbot_config 07:17:26 INFO - Using buildbot properties: 07:17:26 INFO - { 07:17:26 INFO - "project": "", 07:17:26 INFO - "product": "firefox", 07:17:26 INFO - "script_repo_revision": "production", 07:17:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:17:26 INFO - "repository": "", 07:17:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:17:26 INFO - "buildid": "20151229043001", 07:17:26 INFO - "pgo_build": "True", 07:17:26 INFO - "basedir": "/builds/slave/test-pgo", 07:17:26 INFO - "buildnumber": 621, 07:17:26 INFO - "slavename": "talos-linux64-ix-030", 07:17:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:17:26 INFO - "platform": "ubuntu64_hw", 07:17:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:17:26 INFO - "branch": "mozilla-central", 07:17:26 INFO - "repo_path": "mozilla-central", 07:17:26 INFO - "revision": "9ddf0da90fb3bc1ae29966dc596013fc54a44bd2", 07:17:26 INFO - "stage_platform": "linux64-pgo", 07:17:26 INFO - "builduid": "5773e6c0f17249b9ad7c605c177a0565", 07:17:26 INFO - "slavebuilddir": "test" 07:17:26 INFO - } 07:17:26 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:26 INFO - Running post-action listener: _resource_record_post_action 07:17:26 INFO - ##### 07:17:26 INFO - ##### Running download-and-extract step. 07:17:26 INFO - ##### 07:17:26 INFO - Running pre-action listener: _resource_record_pre_action 07:17:26 INFO - Running main action method: download_and_extract 07:17:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:26 INFO - https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:17:26 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:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/test_packages.json 07:17:26 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:26 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:29 INFO - Downloaded 1302 bytes. 07:17:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:17:29 INFO - Using the following test package requirements: 07:17:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:17:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:29 INFO - u'jsshell-linux-x86_64.zip'], 07:17:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:17:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:17:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:17:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:17:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:17:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:17:29 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:29 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:29 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:29 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:29 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:29 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:30 INFO - Downloaded 23192066 bytes. 07:17:30 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:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:17:30 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:31 INFO - Return code: 0 07:17:31 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:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:31 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:31 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:31 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:31 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:31 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 - 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.talos.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.talos.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.talos.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.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.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.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:43 INFO - Downloaded 11132270 bytes. 07:17:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:17:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:17:44 INFO - Return code: 0 07:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:44 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:44 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:44 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:44 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:44 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:46 INFO - Downloaded 54913574 bytes. 07:17:46 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:46 INFO - mkdir: /builds/slave/test-pgo/properties 07:17:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:17:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:17:46 INFO - Contents: 07:17:46 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:46 INFO - Running post-action listener: _resource_record_post_action 07:17:46 INFO - Running post-action listener: set_extra_try_arguments 07:17:46 INFO - ##### 07:17:46 INFO - ##### Running populate-webroot step. 07:17:46 INFO - ##### 07:17:46 INFO - Running pre-action listener: _resource_record_pre_action 07:17:46 INFO - Running main action method: populate_webroot 07:17:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:46 INFO - '--tppagecycles', 07:17:46 INFO - '7'], 07:17:46 INFO - 'tests': ['tsvgm']}}, 07:17:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:17:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:17:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:17:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:46 INFO - 'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:46 INFO - 'tests': ['damp', 'tps']}, 07:17:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:46 INFO - 'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['damp', 'tps']}, 07:17:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:17:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:46 INFO - 'other': {'tests': ['a11yr', 07:17:46 INFO - 'ts_paint', 07:17:46 INFO - 'tpaint', 07:17:46 INFO - 'sessionrestore', 07:17:46 INFO - 'sessionrestore_no_auto_restore']}, 07:17:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['a11yr', 07:17:46 INFO - 'ts_paint', 07:17:46 INFO - 'tpaint', 07:17:46 INFO - 'sessionrestore', 07:17:46 INFO - 'sessionrestore_no_auto_restore']}, 07:17:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['a11yr', 07:17:46 INFO - 'ts_paint', 07:17:46 INFO - 'tpaint', 07:17:46 INFO - 'sessionrestore', 07:17:46 INFO - 'sessionrestore_no_auto_restore']}, 07:17:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['a11yr', 07:17:46 INFO - 'ts_paint', 07:17:46 INFO - 'tpaint', 07:17:46 INFO - 'sessionrestore', 07:17:46 INFO - 'sessionrestore_no_auto_restore']}, 07:17:46 INFO - 'other_l64': {'tests': ['a11yr', 07:17:46 INFO - 'ts_paint', 07:17:46 INFO - 'tpaint', 07:17:46 INFO - 'sessionrestore', 07:17:46 INFO - 'sessionrestore_no_auto_restore']}, 07:17:46 INFO - 'other_nol64': {'tests': ['a11yr', 07:17:46 INFO - 'ts_paint', 07:17:46 INFO - 'tpaint', 07:17:46 INFO - 'sessionrestore', 07:17:46 INFO - 'sessionrestore_no_auto_restore']}, 07:17:46 INFO - 'svgr': {'tests': ['tsvgx', 07:17:46 INFO - 'tsvgr_opacity', 07:17:46 INFO - 'tart', 07:17:46 INFO - 'tscrollx', 07:17:46 INFO - 'cart']}, 07:17:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['tsvgx', 07:17:46 INFO - 'tsvgr_opacity', 07:17:46 INFO - 'tart', 07:17:46 INFO - 'tscrollx', 07:17:46 INFO - 'cart']}, 07:17:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:46 INFO - 'tests': ['tp5o']}, 07:17:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:46 INFO - 'talos_options': ['--e10s'], 07:17:46 INFO - 'tests': ['tp5o']}, 07:17:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:46 INFO - 'talos_options': ['--xperf_path', 07:17:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:46 INFO - 'tests': ['tp5n']}, 07:17:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:17:46 INFO - 'talos_options': ['--e10s', 07:17:46 INFO - '--xperf_path', 07:17:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:46 INFO - 'tests': ['tp5n']}}, 07:17:46 INFO - 'talos.zip': {'path': '', 07:17:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:46 INFO - Running post-action listener: _resource_record_post_action 07:17:46 INFO - ##### 07:17:46 INFO - ##### Running create-virtualenv step. 07:17:46 INFO - ##### 07:17:46 INFO - Running pre-action listener: _resource_record_pre_action 07:17:46 INFO - Running main action method: create_virtualenv 07:17:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:17:46 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:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:17:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:46 INFO - Using real prefix '/usr' 07:17:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:17:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:48 INFO - Installing pip.................done. 07:17:48 INFO - Return code: 0 07:17:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:17:48 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:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:48 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:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:48 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 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 07:17:48 INFO - 'HOME': '/home/cltbld', 07:17:48 INFO - 'LANG': 'en_US.UTF-8', 07:17:48 INFO - 'LANGUAGE': 'en_US:en', 07:17:48 INFO - 'LOGNAME': 'cltbld', 07:17:48 INFO - 'MAIL': '/var/mail/cltbld', 07:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:48 INFO - 'MOZ_NO_REMOTE': '1', 07:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:48 INFO - 'NO_EM_RESTART': '1', 07:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:17:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:17:48 INFO - 'SHELL': '/bin/bash', 07:17:48 INFO - 'SHLVL': '1', 07:17:48 INFO - 'TERM': 'linux', 07:17:48 INFO - 'TMOUT': '86400', 07:17:48 INFO - 'USER': 'cltbld', 07:17:48 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 07:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:48 INFO - '_': '/tools/buildbot/bin/python'} 07:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:49 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:49 INFO - Cleaning up... 07:17:49 INFO - Return code: 0 07:17:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:17:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:17:49 INFO - Using env: {'DISPLAY': ':0', 07:17:49 INFO - 'HOME': '/home/cltbld', 07:17:49 INFO - 'LANG': 'en_US.UTF-8', 07:17:49 INFO - 'LANGUAGE': 'en_US:en', 07:17:49 INFO - 'LOGNAME': 'cltbld', 07:17:49 INFO - 'MAIL': '/var/mail/cltbld', 07:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:49 INFO - 'MOZ_NO_REMOTE': '1', 07:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:49 INFO - 'NO_EM_RESTART': '1', 07:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:17:49 INFO - 'PWD': '/builds/slave/test-pgo', 07:17:49 INFO - 'SHELL': '/bin/bash', 07:17:49 INFO - 'SHLVL': '1', 07:17:49 INFO - 'TERM': 'linux', 07:17:49 INFO - 'TMOUT': '86400', 07:17:49 INFO - 'USER': 'cltbld', 07:17:49 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 07:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:49 INFO - '_': '/tools/buildbot/bin/python'} 07:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:49 INFO - Downloading/unpacking psutil>=0.7.1 07:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:17:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:17:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:51 INFO - Installing collected packages: psutil 07:17:51 INFO - Running setup.py install for psutil 07:17:51 INFO - building 'psutil._psutil_linux' extension 07:17:51 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:17:51 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:17:51 INFO - building 'psutil._psutil_posix' extension 07:17:51 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:17:51 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:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:51 INFO - Successfully installed psutil 07:17:51 INFO - Cleaning up... 07:17:51 INFO - Return code: 0 07:17:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:17:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:51 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 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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:51 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:17:51 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:17:51 INFO - Using env: {'DISPLAY': ':0', 07:17:51 INFO - 'HOME': '/home/cltbld', 07:17:51 INFO - 'LANG': 'en_US.UTF-8', 07:17:51 INFO - 'LANGUAGE': 'en_US:en', 07:17:51 INFO - 'LOGNAME': 'cltbld', 07:17:51 INFO - 'MAIL': '/var/mail/cltbld', 07:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:51 INFO - 'MOZ_NO_REMOTE': '1', 07:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:51 INFO - 'NO_EM_RESTART': '1', 07:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:17:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:17:51 INFO - 'SHELL': '/bin/bash', 07:17:51 INFO - 'SHLVL': '1', 07:17:51 INFO - 'TERM': 'linux', 07:17:51 INFO - 'TMOUT': '86400', 07:17:51 INFO - 'USER': 'cltbld', 07:17:51 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 07:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:51 INFO - '_': '/tools/buildbot/bin/python'} 07:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:17:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:17:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:17:53 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:17:53 INFO - Installing collected packages: mozsystemmonitor 07:17:53 INFO - Running setup.py install for mozsystemmonitor 07:17:53 INFO - Successfully installed mozsystemmonitor 07:17:53 INFO - Cleaning up... 07:17:53 INFO - Return code: 0 07:17:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:53 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 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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:53 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:17:53 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:17:53 INFO - Using env: {'DISPLAY': ':0', 07:17:53 INFO - 'HOME': '/home/cltbld', 07:17:53 INFO - 'LANG': 'en_US.UTF-8', 07:17:53 INFO - 'LANGUAGE': 'en_US:en', 07:17:53 INFO - 'LOGNAME': 'cltbld', 07:17:53 INFO - 'MAIL': '/var/mail/cltbld', 07:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:53 INFO - 'MOZ_NO_REMOTE': '1', 07:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:53 INFO - 'NO_EM_RESTART': '1', 07:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:17:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:17:53 INFO - 'SHELL': '/bin/bash', 07:17:53 INFO - 'SHLVL': '1', 07:17:53 INFO - 'TERM': 'linux', 07:17:53 INFO - 'TMOUT': '86400', 07:17:53 INFO - 'USER': 'cltbld', 07:17:53 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 07:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:53 INFO - '_': '/tools/buildbot/bin/python'} 07:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:17:53 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:53 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:53 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:53 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:53 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:53 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:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:17:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:17:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:17:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:17:55 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:55 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:55 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:55 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:55 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:55 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:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:17:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:17:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:17:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Downloading docopt-0.6.1.tar.gz 07:17:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:17:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:17:56 INFO - Installing collected packages: blobuploader, requests, docopt 07:17:56 INFO - Running setup.py install for blobuploader 07:17:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:17:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:17:56 INFO - Running setup.py install for requests 07:17:56 INFO - Running setup.py install for docopt 07:17:56 INFO - Successfully installed blobuploader requests docopt 07:17:56 INFO - Cleaning up... 07:17:56 INFO - Return code: 0 07:17:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:56 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 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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:56 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:17:56 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:17:56 INFO - Using env: {'DISPLAY': ':0', 07:17:56 INFO - 'HOME': '/home/cltbld', 07:17:56 INFO - 'LANG': 'en_US.UTF-8', 07:17:56 INFO - 'LANGUAGE': 'en_US:en', 07:17:56 INFO - 'LOGNAME': 'cltbld', 07:17:56 INFO - 'MAIL': '/var/mail/cltbld', 07:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:56 INFO - 'MOZ_NO_REMOTE': '1', 07:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:56 INFO - 'NO_EM_RESTART': '1', 07:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:17:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:17:56 INFO - 'SHELL': '/bin/bash', 07:17:56 INFO - 'SHLVL': '1', 07:17:56 INFO - 'TERM': 'linux', 07:17:56 INFO - 'TMOUT': '86400', 07:17:56 INFO - 'USER': 'cltbld', 07:17:56 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 07:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:56 INFO - '_': '/tools/buildbot/bin/python'} 07:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:17:57 INFO - Running setup.py (path:/tmp/pip-Py9xYv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:17:57 INFO - Running setup.py (path:/tmp/pip-3Oax3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:17:57 INFO - Running setup.py (path:/tmp/pip-c3UUks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:17:57 INFO - Running setup.py (path:/tmp/pip-tTZ8Uh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:17:57 INFO - Running setup.py (path:/tmp/pip-B8IJpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:17:57 INFO - Running setup.py (path:/tmp/pip-islHkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:17:57 INFO - Running setup.py (path:/tmp/pip-oYzeEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:17:57 INFO - Running setup.py (path:/tmp/pip-6W4cVb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:17:57 INFO - Running setup.py (path:/tmp/pip-5d5dFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:17:57 INFO - Running setup.py (path:/tmp/pip-FTZzeQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:17:57 INFO - Running setup.py (path:/tmp/pip-HFJVYj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:17:57 INFO - Running setup.py (path:/tmp/pip-LQFL6h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:17:58 INFO - Running setup.py (path:/tmp/pip-24jlED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:17:58 INFO - Running setup.py (path:/tmp/pip-ZqcWaY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:17:58 INFO - Running setup.py (path:/tmp/pip-iubQIi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:17:58 INFO - Running setup.py (path:/tmp/pip-GVReVu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:17:58 INFO - Running setup.py (path:/tmp/pip-H7GHLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:17:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:17:58 INFO - Running setup.py install for manifestparser 07:17:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:17:58 INFO - Running setup.py install for mozcrash 07:17:58 INFO - Running setup.py install for mozdebug 07:17:58 INFO - Running setup.py install for mozdevice 07:17:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:17:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:17:58 INFO - Running setup.py install for mozfile 07:17:58 INFO - Running setup.py install for mozhttpd 07:17:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:17:58 INFO - Running setup.py install for mozinfo 07:17:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Running setup.py install for mozInstall 07:17:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Running setup.py install for mozleak 07:17:59 INFO - Running setup.py install for mozlog 07:17:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Running setup.py install for moznetwork 07:17:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Running setup.py install for mozprocess 07:17:59 INFO - Running setup.py install for mozprofile 07:17:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Running setup.py install for mozrunner 07:17:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:17:59 INFO - Running setup.py install for mozscreenshot 07:17:59 INFO - Running setup.py install for moztest 07:18:00 INFO - Running setup.py install for mozversion 07:18:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:18:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:18:00 INFO - Cleaning up... 07:18:00 INFO - Return code: 0 07:18:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:18:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:00 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 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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:00 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:00 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:00 INFO - Using env: {'DISPLAY': ':0', 07:18:00 INFO - 'HOME': '/home/cltbld', 07:18:00 INFO - 'LANG': 'en_US.UTF-8', 07:18:00 INFO - 'LANGUAGE': 'en_US:en', 07:18:00 INFO - 'LOGNAME': 'cltbld', 07:18:00 INFO - 'MAIL': '/var/mail/cltbld', 07:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:00 INFO - 'MOZ_NO_REMOTE': '1', 07:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:00 INFO - 'NO_EM_RESTART': '1', 07:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:00 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:00 INFO - 'SHELL': '/bin/bash', 07:18:00 INFO - 'SHLVL': '1', 07:18:00 INFO - 'TERM': 'linux', 07:18:00 INFO - 'TMOUT': '86400', 07:18:00 INFO - 'USER': 'cltbld', 07:18:00 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 07:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:00 INFO - '_': '/tools/buildbot/bin/python'} 07:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:18:00 INFO - Running setup.py (path:/tmp/pip-S61Bwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:18:00 INFO - Running setup.py (path:/tmp/pip-_RbDSm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:18:00 INFO - Running setup.py (path:/tmp/pip-L7diN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:18:00 INFO - Running setup.py (path:/tmp/pip-vu4gPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:18:00 INFO - Running setup.py (path:/tmp/pip-0nz94t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:18:00 INFO - Running setup.py (path:/tmp/pip-WE2Tgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:18:00 INFO - Running setup.py (path:/tmp/pip-wdZ_OM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:18:00 INFO - Running setup.py (path:/tmp/pip-lS9bsz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:18:00 INFO - Running setup.py (path:/tmp/pip-1eTZA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:18:00 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:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:18:00 INFO - Running setup.py (path:/tmp/pip-2_kgHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:18:01 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:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:18:01 INFO - Running setup.py (path:/tmp/pip-YrXYr9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:18:01 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:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:18:01 INFO - Running setup.py (path:/tmp/pip-wDdYhs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:18:01 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:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:18:01 INFO - Running setup.py (path:/tmp/pip-pb1c3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:18:01 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:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:18:01 INFO - Running setup.py (path:/tmp/pip-ZoLp0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:18:01 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:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:18:01 INFO - Running setup.py (path:/tmp/pip-1sxQ7u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:18:01 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:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:18:01 INFO - Running setup.py (path:/tmp/pip-6MrJEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:18:01 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:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:18:01 INFO - Running setup.py (path:/tmp/pip-5IBKqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:18:01 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:01 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:01 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:01 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:01 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:01 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:01 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: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:03 INFO - Downloading blessings-1.5.1.tar.gz 07:18:03 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:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:18:03 INFO - Installing collected packages: blessings 07:18:03 INFO - Running setup.py install for blessings 07:18:03 INFO - Successfully installed blessings 07:18:03 INFO - Cleaning up... 07:18:03 INFO - Return code: 0 07:18:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:18:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:18:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:18:03 INFO - Reading from file tmpfile_stdout 07:18:03 INFO - Current package versions: 07:18:03 INFO - argparse == 1.2.1 07:18:03 INFO - blessings == 1.5.1 07:18:03 INFO - blobuploader == 1.2.4 07:18:03 INFO - docopt == 0.6.1 07:18:03 INFO - manifestparser == 1.1 07:18:03 INFO - mozInstall == 1.12 07:18:03 INFO - mozcrash == 0.16 07:18:03 INFO - mozdebug == 0.1 07:18:03 INFO - mozdevice == 0.47 07:18:03 INFO - mozfile == 1.2 07:18:03 INFO - mozhttpd == 0.7 07:18:03 INFO - mozinfo == 0.9 07:18:03 INFO - mozleak == 0.1 07:18:03 INFO - mozlog == 3.1 07:18:03 INFO - moznetwork == 0.27 07:18:03 INFO - mozprocess == 0.22 07:18:03 INFO - mozprofile == 0.28 07:18:03 INFO - mozrunner == 6.11 07:18:03 INFO - mozscreenshot == 0.1 07:18:03 INFO - mozsystemmonitor == 0.0 07:18:03 INFO - moztest == 0.7 07:18:03 INFO - mozversion == 1.4 07:18:03 INFO - psutil == 3.1.1 07:18:03 INFO - requests == 1.2.3 07:18:03 INFO - wsgiref == 0.1.2 07:18:03 INFO - Installing None 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', '-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 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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', '-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:03 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: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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 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 - 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:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Cleaning up... 07:18:03 INFO - Return code: 0 07:18:03 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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', 'jsonschema'] 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 jsonschema 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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 07:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:03 INFO - '_': '/tools/buildbot/bin/python'} 07:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:04 INFO - Downloading/unpacking jsonschema 07:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:18:05 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:05 INFO - Downloading/unpacking functools32 (from jsonschema) 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 functools32-3.2.3-2.tar.gz 07:18:05 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:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:18:06 INFO - warning: no files found matching '*.txt' 07:18:06 INFO - no previously-included directories found matching 'build' 07:18:06 INFO - no previously-included directories found matching 'dist' 07:18:06 INFO - no previously-included directories found matching '.git*' 07:18:06 INFO - Installing collected packages: jsonschema, functools32 07:18:06 INFO - Running setup.py install for functools32 07:18:06 INFO - warning: no files found matching '*.txt' 07:18:06 INFO - no previously-included directories found matching 'build' 07:18:06 INFO - no previously-included directories found matching 'dist' 07:18:06 INFO - no previously-included directories found matching '.git*' 07:18:06 INFO - Successfully installed jsonschema functools32 07:18:06 INFO - Cleaning up... 07:18:06 INFO - Return code: 0 07:18:06 INFO - Installing flake8 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', '--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 0x7f8295388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a40630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', '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', '--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:06 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: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': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 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 - Downloading/unpacking flake8 07:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:18:08 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:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:18:08 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:08 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:08 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:08 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:08 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:08 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:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:18:08 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:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:18:08 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:08 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:08 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:08 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:08 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:08 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:08 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:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:18:08 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:08 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:08 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:08 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:08 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:08 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:08 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:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:18:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:18:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:18:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:18:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:18:08 INFO - no previously-included directories found matching 'docs/_build' 07:18:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:18:08 INFO - Running setup.py install for pep8 07:18:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:18:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:18:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:18:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:18:08 INFO - no previously-included directories found matching 'docs/_build' 07:18:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:18:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:18:08 INFO - Cleaning up... 07:18:09 INFO - Return code: 0 07:18:09 INFO - Running post-action listener: _resource_record_post_action 07:18:09 INFO - Running post-action listener: _start_resource_monitoring 07:18:09 INFO - Starting resource monitoring. 07:18:09 INFO - ##### 07:18:09 INFO - ##### Running install step. 07:18:09 INFO - ##### 07:18:09 INFO - Running pre-action listener: _resource_record_pre_action 07:18:09 INFO - Running main action method: install 07:18:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:18:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:18:09 INFO - Reading from file tmpfile_stdout 07:18:09 INFO - Detecting whether we're running mozinstall >=1.0... 07:18:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:18:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:18:09 INFO - Reading from file tmpfile_stdout 07:18:09 INFO - Output received: 07:18:09 INFO - Usage: mozinstall [options] installer 07:18:09 INFO - Options: 07:18:09 INFO - -h, --help show this help message and exit 07:18:09 INFO - -d DEST, --destination=DEST 07:18:09 INFO - Directory to install application into. [default: 07:18:09 INFO - "/builds/slave/test-pgo"] 07:18:09 INFO - --app=APP Application being installed. [default: firefox] 07:18:09 INFO - mkdir: /builds/slave/test-pgo/build/application 07:18:09 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:09 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:25 INFO - Reading from file tmpfile_stdout 07:18:25 INFO - Output received: 07:18:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:18:25 INFO - Running post-action listener: _resource_record_post_action 07:18:25 INFO - ##### 07:18:25 INFO - ##### Running run-tests step. 07:18:25 INFO - ##### 07:18:25 INFO - Running pre-action listener: _resource_record_pre_action 07:18:25 INFO - Running main action method: run_tests 07:18:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:18:25 INFO - Python 2.7.3 07:18:25 INFO - Return code: 0 07:18:25 INFO - grabbing minidump binary from tooltool 07:18:25 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:25 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 0x1ad1840>, '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 0x1a3e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:18:25 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:25 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:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:25 INFO - Return code: 0 07:18:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:18:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:18:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:18:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:18:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:18:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:18:26 INFO - Return code: 0 07:18:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:18:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:18:26 INFO - Using env: {'DISPLAY': ':0', 07:18:26 INFO - 'HOME': '/home/cltbld', 07:18:26 INFO - 'LANG': 'en_US.UTF-8', 07:18:26 INFO - 'LANGUAGE': 'en_US:en', 07:18:26 INFO - 'LOGNAME': 'cltbld', 07:18:26 INFO - 'MAIL': '/var/mail/cltbld', 07:18:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:18:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:26 INFO - 'MOZ_NO_REMOTE': '1', 07:18:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:26 INFO - 'NO_EM_RESTART': '1', 07:18:26 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:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:18:26 INFO - 'PWD': '/builds/slave/test-pgo', 07:18:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:18:26 INFO - 'SHELL': '/bin/bash', 07:18:26 INFO - 'SHLVL': '1', 07:18:26 INFO - 'TERM': 'linux', 07:18:26 INFO - 'TMOUT': '86400', 07:18:26 INFO - 'USER': 'cltbld', 07:18:26 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830', 07:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:26 INFO - '_': '/tools/buildbot/bin/python'} 07:18:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2D_qhPvhRmqc3baGWm3QKw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:18:26 INFO - mozversion application_buildid: 20151229043001 07:18:26 INFO - mozversion application_changeset: 9ddf0da90fb3bc1ae29966dc596013fc54a44bd2 07:18:26 INFO - mozversion application_display_name: Nightly 07:18:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:26 INFO - mozversion application_name: Firefox 07:18:26 INFO - mozversion application_remotingname: firefox 07:18:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:18:26 INFO - mozversion application_vendor: Mozilla 07:18:26 INFO - mozversion application_version: 46.0a1 07:18:26 INFO - mozversion platform_buildid: 20151229043001 07:18:26 INFO - mozversion platform_changeset: 9ddf0da90fb3bc1ae29966dc596013fc54a44bd2 07:18:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:18:26 INFO - mozversion platform_version: 46.0a1 07:18:26 INFO - using testdate: 1451402306 07:18:26 INFO - actual date: 1451402306 07:18:26 INFO - starting webserver on 'localhost:40045' 07:18:26 INFO - SUITE-START | Running 3 tests 07:18:26 INFO - TEST-START | dromaeo_css 07:18:26 INFO - operating with platform_type : linux_ 07:18:26 INFO - Initialising browser for dromaeo_css test... 07:18:26 INFO - TEST-INFO | started process 11077 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp54SLDQ/profile http://localhost:40045/getInfo.html) 07:18:30 INFO - PROCESS | 11077 | __metrics Screen width/height:1600/1200 07:18:30 INFO - PROCESS | 11077 | colorDepth:24 07:18:30 INFO - PROCESS | 11077 | Browser inner width/height: 1024/697 07:18:30 INFO - PROCESS | 11077 | __metrics 07:18:30 INFO - PROCESS | 11077 | 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:30 INFO - PROCESS | 11077 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:32 INFO - TEST-INFO | 11077: exit 0 07:18:32 INFO - Browser initialized. 07:18:32 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:32 INFO - TEST-INFO | started process 11167 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp54SLDQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:43 INFO - PROCESS | 11167 | RSS: Main: 148303872 07:18:43 INFO - PROCESS | 11167 | 07:19:35 INFO - PROCESS | 11167 | 1451402375513 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:43 INFO - PROCESS | 11167 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40045/tests/dromaeo/cssquery-ext.html) 07:21:44 INFO - PROCESS | 11167 | RSS: Main: 270843904 07:21:44 INFO - PROCESS | 11167 | 07:24:47 INFO - PROCESS | 11167 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-ext.html (next: http://localhost:40045/tests/dromaeo/cssquery-jquery.html) 07:24:48 INFO - PROCESS | 11167 | RSS: Main: 227799040 07:24:48 INFO - PROCESS | 11167 | 07:27:49 INFO - PROCESS | 11167 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40045/tests/dromaeo/cssquery-mootools.html) 07:27:50 INFO - PROCESS | 11167 | RSS: Main: 218259456 07:27:50 INFO - PROCESS | 11167 | 07:30:52 INFO - PROCESS | 11167 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40045/tests/dromaeo/cssquery-prototype.html) 07:30:52 INFO - PROCESS | 11167 | RSS: Main: 211025920 07:30:52 INFO - PROCESS | 11167 | 07:33:55 INFO - PROCESS | 11167 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40045/tests/dromaeo/cssquery-yui.html) 07:33:55 INFO - PROCESS | 11167 | RSS: Main: 219070464 07:33:55 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | Cycle 1(1): loaded http://localhost:40045/tests/dromaeo/cssquery-yui.html (next: http://localhost:40045/tests/dromaeo/cssquery-dojo.html) 07:36:58 INFO - PROCESS | 11167 | RSS: Main: 264486912 07:36:58 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | __start_tp_report 07:36:58 INFO - PROCESS | 11167 | _x_x_mozilla_page_load 07:36:58 INFO - PROCESS | 11167 | _x_x_mozilla_page_load_details 07:36:58 INFO - PROCESS | 11167 | |i|pagename|runs| 07:36:58 INFO - PROCESS | 11167 | |0;dojo.html;3089.397567474343;3144.0567829651127;3178.3643271345736;3184.2517008503014;3208.887688930887;4951.727654978975;5098.439171691111;5171.146760784471;5178.378594568648;5206.7656955437005;5131.666441681288;5142.871428214296;5150.1759718445055;5237.292965449663;5252.264682944391;4675.883102922428;4721.669483136182;4737.123632128068;4740.834070807522;4800.303955926389;4809.110314591794;4819.5180481951875;4839.975800120995;4846.87882802931;4873.22028475444;4692.976535117303;4720.480747117815;4780;4796;4807.591354734835;4763.785629646674;4766.165920963817;4769.928451073237;4781.497942716;4802.207635740098;4748.667593268473;4748.9525104748855;4752.168370535177;4777.235642297216;4783.4977327380475;4866.562009419169;4940.407151141886;4963.354763880709;5019.774110165052;5045.091883461012;5582.525485333711;5585.385607583204;5586.888262234773;5588.1059030555325;5619.494245517923;5601.215829783793;5608.990381731287;5610.13042978339;5610.887782244332;5620.85947851307;5002.099622068026;5048.5203905628905;5114.462981386938;5183.377994640668;5218.869528261824;5673.3475650299915;5675.77296908119;5720.856978575485;5724.398938111522;5728.627639203439;5426.565874730012;5466.398696143421;5467.699276539749;5470.124780035176;5479.4520547944885;5357.142857142839;5463.344398672185;5472.069748142825;5517.420670829505;5540.36285827135;5567.415421380778;5569.554435645138;5570.916436253459;5576.052071147834;5608.046632072557;5459.208414779835;5529.060059789846;5561.193626924073;5565.693886836182;5568.554515638739;4201.495820501559;4297.183535128315;4304.203722311382;4359.80380882861;4377.4965878923695;3882.456456096149;3893.824777885002;3905.199434116056;3913.4521167036637;3922.3920292354733;5108.157154069537;5140.948590514047;5160.277561141444;5163.40620828602;5231.503007214308;5374.247605335257;5472.480114389126;5475.0418676731415;5531.944680553223;5534.667919924817;5099.260607212008;5141.074606570854;5145.279660847485;5145.588352931756;5165.819196328111;4799.208130658402;4803.135435621622;4806.038792241566;4818.445878723922;4841.733704646208;5560.694161821058;5677.233573467612;5716.142578613241;5735.627184233012;5830.7959221427045;5495.587830912617;5496.862578435571;5500.202470641814;5501.972490137524;5506.339239291311;5563.916541251965;5576.052071147834;5578.358488773681;5590.608657393944;5686.43135686428;5298.602604804578;5363.704996225089;5377.596680248918;5441.673499590037;5451.7274136292235;5572.916406253828;5600.215969764155;5600.243967064557;5600.747966341443;5601.439856014366;5241.868953276198;5381.354237491526;5463.125899856004;5487.835364939058;5533.170024496358;5286.81496147633;5328.387235467816;5338.813141540028;5374.408815030265;5381.058314794817;5209.661372010807;5210.869728256824;5234.842954711365;5235.345581802275;5243.711595862112;5226.973865130803;5293.682379057115;5306;5318.734063296897;5378.838634840961;5276.736163191748;5301.973490132525;5354.063038968243;5359;5363.517283444508 07:36:58 INFO - PROCESS | 11167 | |1;ext.html;524.7114087252011;530.0485628297206;532.7629205003774;547.5482726750432;555.0868820789801;28274.57588136177;28843.855780721093;35983.640163598386;36386.8180659097;36479.81760091202;38171;38608;38669.226615467676;38716;38717.806410967976;8370.372222083353;8530.74407767765;8545.572721363938;8546.52994085325;8547.786305342384;7643.656035478417;7810.726624568141;9974.052465015811;10161.187105031617;10164.898351016505;9898.901010989906;9902.702918912444;9958.203343732484;9958.751031224241;9973.102420782128;7628.160902300742;7787.883181752279;9856.901430985707;9885.060919212663;9963.950180249089;7390.704371825121;9947.502624868728;10174.338667986558;10179.440130792804;10182.898171018269;35582.11044723877;35989.46015809765;36017.118630509496;36034.45948310778;36046;3237.352529494087;3242.1084201844683;3278.8196649184283;3502.404591219499;3658.9268214635827;27839.86080069607;28183.57724634132;28800.423991520263;29508.557371639443;30695.846520767253;3723.1995121049104;3804.144067584799;3817.8281977310808;3955.149642826806;4014.116894283253;265588;265761;266555.9999999981;267553;268120;52049.739751301;53178.202326965125;57760.133597996064;58095.419045809;58165.70917145387;50565;50687.7465612677;50867;50868.49131508637;50891.491085089416;16068.196590170444;16351.67296654084;16358.427455039255;16359.836401635832;16361.754573681405;11566.363849988164;11630.88369116315;11638.76722465546;11707.239029463057;11710.94144529272;19180.734856007944;19449.932075020955;19463.976256399066;19543.609127817363;19581.020948952497;7235.095613048369;7346.926530734624;7428.33510222181;7441.553506789502;7451.85096298071;874.3529787956993;897.4211633496358;939.4269495607674;960.8174446855076;1016.2885979814012;23452.64821027686;23808.523829523314;23935.640965385533;24082;24122.638160427607;1004.2919741582167;1008.909198172168;1042.2027149230844;1055.8363453664695;1131.7510147767478;13153.802692959613;13261.500619905726;13386;13956.860431395758;14001.43994240219;327180;330370;330457.3908521816;330512;332892;44947.55052449499;44968.55031449709;45002.32496512555;45007.77496112498;45129.09741805145;1334.9666258343618;1361.2717196299932;1361.9591412257648;1363.0390574644853;1445.6096853849401;25167.49665006653;26370.604440933017;26389.340266492723;26465;26466.735332646425;42035.7898210507;42465;42610.57389426066;42634.57365426306;42680.78659606682;311533;313609;314191;314342;314426;27050.32374190661;27965.86017069983;28448.57327140053;30695.386092277582;31502.369952600362;37392.25215495621;37648.811755941046;37674.62325376711;38058.429123562615;38067.809660952626;31737.740936782553;31894.362112758077;32218.35563288768;32325.35349293048;32607.836960815042;28066.579001315404;30173;30503.847480762455;31577.526337104504;33346;32062.35875282528;35949.46075808813;36447.63552364442;36461.635383646884;36554;27584.44831103407;29157.854210728812;29197.85401072981;29404.11787646374;29521.557176642797;22967.196148134735;23644.408889777893;24157.63763543513;24388.6341704871;24413.51172976495 07:36:58 INFO - PROCESS | 11167 | |2;jquery.html;349.3781069695941;349.45136136266075;349.97725147865384;353.64105432985525;354.3126334910272;14106.365213565388;14608.561743147722;16286.918565407172;16441.83558164418;17181.65636687267;15825.762613560777;15878;16445.25996330165;16505.669886602293;16509.58726031847;5476.58925580581;5677.886442271152;5683.403242659523;5684.147377893308;5684.687342196177;4238.088810905655;5648.096304591266;5953.583249172538;6593.934060659404;6610.93389066108;6434.356564343575;6546.738130474775;6553.410193082622;6572.474202063823;6594.340565943416;6502.869942601145;6530.738770449177;6547.508936829757;6549.181352330958;6550.67246637671;5833.066709326487;5844.152597873327;5992.011318132503;6252.437280644764;6262.12330273762;21918.78081219199;21947.341579752632;22677.2062977795;22683;22690;2163.610550100981;2199.3401979406112;2294.460801711613;2307.619242824932;2349.283468542094;14167.645808854759;14219.146851188962;14272.857271427256;14279.714405711931;14386.136831790021;1901.9239230430767;1987.1554589299635;1992.4620352504742;1994.8503862210248;2007.749556531139;67412;68060.31939680639;68755.3124468754;70721.64639176823;70764.29235707628;11876.287422754489;15128.848711512965;15195.848041519665;15479.922600387152;15695.921520392325;24289.27132186037;24362.756372436404;24569.14008009711;24582.385440363778;24583.754162458146;9138.680146194984;9243.075692430837;9279.072092790668;9318.580663870142;9344.065593440602;7916.247956444128;7963.4425590209285;7977;8010.839783204303;8035.517868927883;7161.606111663908;7873.409494287951;7892.60536973149;7934.523928564305;8017.358611311198;2796.7482926536304;2961.5705722670523;2964.955525667117;2989.5067313892964;3002.8948986785795;834.6953362022939;990.0594435286507;993.2600212841479;997.9351342162736;1008.4554340655964;14180.220087895059;15519.456819011506;15585.766213506806;15998.76001859973;16372.426965056165;922.4050487435567;938.779386844091;968.6803354892868;971.2666936462925;1017.9694609161589;8861.158189971942;9204.59880335217;9212.124848139416;9253.167214950687;9437.480938548446;415975;420526;422680;456729;603299;78555;81460.14889478839;81768.59115704383;82017;82535;1067.5249513966367;1088.2219213262556;1091.6943255888364;1115.8772535021142;1140.2246472398683;15410;15532.068075915482;15588.220588970733;15714.449994250146;15819.52541423759;35714.28571428609;36078.8196059018;36289.637103629684;36329.63670363263;36422.99673517982;46665.76667116643;46834.29748553706;47608.52391476041;47798.283025755336;48468.5153148464;8947;9331.906680933374;9429.15137637616;9439.150476457151;9440.48077355752;11089.778204435705;11318.547258109913;11319.207655464368;13464.461421543028;16850.831491684927;13724.382402791698;13737.587872363845;14087;14768.852311476749;14782.408703651734;13868.791968120688;13968.79046814319;14069.155850648995;14182.581741826147;14561.271936402925;13854.792178117537;14161.362738676578;14496.565103046925;14582.979191456496;14980.925095374889;9277.582508786985;9351.158395744416;9365.344425890122;9487.762805929908;9525.333226674065;10137.949310253402;12563.18339307942;13667.658308541968;13835.792463113263;14693.485727999469 07:36:58 INFO - PROCESS | 11167 | |3;mootools.html;1289.6389011076901;1416.5467050543828;1436.2818590704644;1542.575791657294;1731.0911771320064;6281.340459251775;6806.387425131743;6915.1701795784575;6917.654117294134;6918.2389937107;6737.461003119751;6853.7943861684225;6887.7589284374935;6894.413974812134;6907.827304317395;2161.621716199663;2203.6474164133742;2205.834562407818;2206.5476577301615;2209.171560664751;2165.577712346093;2203.0857194264363;2217.9556408871813;2221.0782525252002;2237.19460994042;2179.8692078475265;2195.407240045187;2215.579039982398;2217.2350539063996;2235.4523141830273;2129.7124888140056;2160.384290477214;2162.178372218563;2163.697082408464;2176.075168053571;2175.369142948543;2228.1198926424136;2232.8995195216253;2233.218373569254;2233.3858188997992;6832.965835170792;6901.413379862718;6904.3095690431055;6910.101686780737;6910.274421185753;4290.4636920384955;4351.608355248011;4354.912901741947;4379.846705365297;4380.737155770632;2874.1377586724107;2918.4017276458276;2925.648922129337;2932.5601159825983;2950.114965510338;908.7410088124852;918.5407296351824;922.6171138977317;942.0297093993198;948.4972964328848;9667.468289244089;9689.1279784819;9694.36986595869;9696.95151524238;9706.805863882682;3873.360895452275;3950.2692001979726;3982.9402558961638;3994.560598334181;4091.6112969267874;7585.810354741066;7635.503692259986;7656.425768067417;7669.769906902802;7674;4396.934045989313;4430.9587246996925;4435.733855968652;4440.156370289699;4442.444694413199;3507.7719948203285;3596.6583174598372;4041.2523683118716;4060.573639767841;4113.876583702494;3479.478078288277;3494.8776792812127;3524.947125793115;3541.592716837545;3568.286342731464;1114.0975809594254;1142.948567314473;1149.2127892393569;1161.8838116188313;1174.5301879248368;1075.4138994248153;1091.061686949223;1095.5672509358758;1203.6389083275158;1289.6066699656508;6517.087607734921;6587.83530411734;6626.105475760711;6661.2006559213205;6675.499337549606;497.572088004316;504.16560592219935;508.1209507551882;515.9767810448539;516.468037920942;5284.339457567804;5313.867153321198;5318.70747108905;5319.627626066215;5321.095413779667;7967.123616402191;8013.318867896294;8122.06596241428;8135.511869287861;8218.506889586644;8066.637001334954;8088.069871964799;8131.14622964592;8154.062282837431;8161;6451.29035806061;6558.37695418944;6648.900266496006;6671.066050752898;6711.127553418122;6317.052442133717;6365.077063825626;6367.044943258548;6368.267649220399;6386.361363863576;7375.889361659687;7389.630518474162;7477.140128885248;7503.962480187564;7645.541267523967;7193.928060719326;7315.670794814139;7411.295926886937;7639.847203056019;7645.732399365996;5448.536874365724;5527.336719593674;6045.667488288186;6212.875742485216;6317.052442133717;6570.77002304917;6598.769043083469;6623.701933412912;6626.56927299724;6630.801075967729;6132.233470816148;6261.624302541862;6358.268799088164;6394.6482943436695;6412.519061070345;6146.170267014075;6197.5351848610635;6213.850437669045;6314.336994615683;6328.177336946352;6100;6112.32764395925;6132;6133.662648554372;6136.171616831671;5729.570282228766;5742.425757424224;5757.107648314518;5758.049921762862;5759.7408116634015;5676.858078548069;5761.913571296518;5764.423557644202;5767.942320576908;5776.306843178845 07:36:58 INFO - PROCESS | 11167 | |4;prototype.html;333.46645367412134;336.6179386396439;338.70701842905896;343.5791155834103;344.32168627803236;5879.8824023519555;5896.321922978858;5920.3191632962225;5960.19537362456;5965.164876917235;5633.577481688869;5716.28546431696;5794.478496935275;5862.384449632791;5880.9411905880925;4572;4577.375031863682;4579.427571553556;4580.3358513015755;4581.40441742573;4347.652187824982;4585.908281834361;4595.58639722425;4600.97699511502;4602.6778125531055;4383.539728328511;4415.227335216325;4487.326900964848;4495.3931219285305;4517.186906356855;4473.686841921067;4481.865544033684;4489.1919454498175;4490.461144662645;4504.729716217037;4005.0588111793704;4010.1177740896956;4010.6791456683395;4019.216252830699;4020.4773379460776;5508.394076651565;5601.691906945116;5607.271054762855;5611.046122159243;5616.185653080322;5268.1834315681135;5278.630495865291;5279.5512381447625;5283.894322113575;5292.047431462335;6253.062040693887;6256.906146407808;6263.217097862767;6264.185655864754;6267.310595834455;4393.538678438782;4395.582419670126;4403.405540252057;4403.471583409979;4407.294832826765;6350.587211831216;6510.869782604369;6529.738810447577;6531.412172904414;6537.705803238866;4563.703359281636;4572;4572.222722137245;4572.565606267399;4573.314002899525;4623.306504024356;4626.791794369262;4631.143238500888;4631.421072365954;4632.050429661911;5301.840944771663;5304.814331498379;5307.071262529042;5308.23030660552;5311.601629877775;6137.631742095488;6313.621182729051;6334.239891212992;6353.174087368612;6364.07720880479;1575.2911189964332;1585.5718955882078;1586.5240427871593;1587.515807678669;1588.809342878862;1044.6865940217904;1053.0206907576028;1058.3226734889677;1058.576569372242;1059.750958524746;5951;5961.254843144607;5964.940350596526;5966.194563733927;5968.820935371946;6485.67571621417;6486;6489.70796314167;6492.415682588589;6496.350364963466;5821.359650438449;5883.382244864313;5933.2880054393745;6021.578489505692;6028.909566356509;3515.1212196950764;3518.7888726676483;3543.326767914088;3543.6456354364873;3546.858125674944;6767.593944363354;6787.389134977876;6797.456203503708;6798.626075565891;6807.523473356818;6544.6727663617585;6655.134832471747;6701.1623547056615;6704.229013663394;6707.228668703064;6795.558288711317;6804.21751498584;6814.48891333152;6818.829529261709;6820.420264277592;6573.83063589024;6574.737010519717;6579.276279609335;6582.901256481061;6583.80248592543;6365.96817015912;6433.002884552901;6483.805485835433;6486;6487.448566871869;6739.5619284746335;6762.4928130389435;6767.898481522682;6782.220044694924;6791.0832037676255;4446.911061778811;4448.110377924363;4448.6663500238255;4451.198784218872;4480.529544397791;6413.230412350548;6523.412892839668;6552.3775241352;6566.277709451861;6580.1116849224745;6392.360763923756;6395.616263024233;6395.6482393468805;6407.97472404413;6409.9038514423255;6378.266499352449;6382.20222472191;6386.233651961795;6388.201474815648;6388.936110638834;6156.2006319116035;6197.783077592263;6241.719122639402;6262.937370626418;6263.467605253604;6416.101745755504;6420.7431702731365;6424.871502570016;6427.742890284337;6437.324080971431;6228.844278893064;6251.156093927261;6261.530385221035;6268.717907694256;6272.121902933684 07:36:58 INFO - PROCESS | 11167 | |5;yui.html;736.4145504324061;816.9183081691831;820.9589520523972;846.2130218896424;882.6601758323047;13817.792733109012;13842.930785346072;13949.721005579882;13961.162330260191;14038.227897465635;12219.083568732358;12285.324307163102;12286.385680715974;12300.692482687937;12337.321447320393;676.3642176354224;690.2097098821846;807.4146243973101;817.207308910356;819.5615345790004;812.7886749445128;818.3739439328918;819.8524265632184;821.9136990615989;825.8100636853527;713.4470785141505;853.5860107847689;854.9572521373938;859.4757198109148;860.8149247911698;714.2357677285307;845.8562044452427;854.2781349759443;857.0700789643245;857.0957639690156;634.1470721879065;634.6065439427584;634.7270673610345;635.2504045226631;635.8156134720972;13382.531611393651;13439.86560134396;13491.595252142353;13508.797368039488;13512;10696.51865666047;10898.237123401364;11771.293722376598;11794.410279486077;12266.141370104096;9918.80162396748;10158.441285729283;10158.695239142837;10254.53854576546;10457.320274182153;3546.4325707886615;3593.586737525192;3606.6393360663988;3609.2781443711365;3714.3871261242134;43699.56300437018;44559;45139.54860451386;45240.09519809618;45247.99999999967;9171.908280917105;9182.816343673223;9188.954055229815;9290.16388525036;9671.661491847752;17001.31994720222;17057.317707291568;17625.471235862944;17636.559086022953;17653.470395888144;7288.854222915618;7413.703451861865;7457.589832559262;7483.251674832473;7581.734639287599;4211.894702632459;4261.509926358446;4282.614564689193;4317.84887528935;4369.038811461473;2933.3839893622153;2958.393529326483;2964.0663191094736;2964.3626620276746;2970;542.4792199488456;552.3234038303046;552.71258945349;553.8144721518256;559.5775189731727;517.5626595526774;545.5954841787219;599.7301214453513;621.59906860075;640.4140211706236;7855.096663883613;7857.528548287121;7914.960425197953;8183.754487365389;8550.572471376407;427.9679024073207;477.77067007836433;516.6925679220858;532.0927818070181;668.5320275806955;3562.7684200526883;3615.9819200903826;3756.9060773480883;3855.4024126260474;3857.5756666766633;51748;51967.22049169266;52011.47988520142;52352.47647523552;52610.473895260555;49173.262401064014;49503.75248123809;50286.74856625694;50292.245616315784;50733;42921.35617965733;43308;43519.78240108779;44240;44411.777941110086;7567.394608431202;7762.184970578008;7782.105057918412;7807.960960195162;8016.799580010546;38514.422283665204;39494.40758388684;39705.60294397019;42291.36562951496;43582;46460.30309545292;46904;50114.498855010985;50920.49079509306;50932;10696.946515267375;10720.127668062974;10868.945655271673;10884.891151088388;11101.611443599435;11357.48891299877;11518.827217591575;11601.071914246671;11634.534618615498;11914.046876250053;10217.33587316822;10322.896771032194;10364;10515.053645171665;10781;10454.477276136315;10624.575016999233;10935.343879367263;11046.281991670516;11117.055050320814;10024.147947424259;10644.680659580225;10662.466876656292;10701.94649026781;10740.409277489813;8799.47203167812;8904.154105359981;9094.545272736468;9203.309751768511;9230.723078307661;8314.542700151549;8467.61895714682;8487.660493580188;8736.78158046054;8904.55477226149 07:36:58 INFO - PROCESS | 11167 | __end_tp_report 07:36:58 INFO - PROCESS | 11167 | __start_cc_report 07:36:58 INFO - PROCESS | 11167 | _x_x_mozilla_cycle_collect,936 07:36:58 INFO - PROCESS | 11167 | __end_cc_report 07:36:58 INFO - PROCESS | 11167 | __startTimestamp1451403418969__endTimestamp 07:36:58 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | ------- Summary: start ------- 07:36:58 INFO - PROCESS | 11167 | Number of tests: 6 07:36:58 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | [#0] dojo.html Cycles:165 Average:5138.97 Median:5276.74 stddev:539.99 (10.2%) stddev-sans-first:517.16 07:36:58 INFO - PROCESS | 11167 | Values: 3089.4 3144.1 3178.4 3184.3 3208.9 4951.7 5098.4 5171.1 5178.4 5206.8 5131.7 5142.9 5150.2 5237.3 5252.3 4675.9 4721.7 4737.1 4740.8 4800.3 4809.1 4819.5 4840.0 4846.9 4873.2 4693.0 4720.5 4780.0 4796.0 4807.6 4763.8 4766.2 4769.9 4781.5 4802.2 4748.7 4749.0 4752.2 4777.2 4783.5 4866.6 4940.4 4963.4 5019.8 5045.1 5582.5 5585.4 5586.9 5588.1 5619.5 5601.2 5609.0 5610.1 5610.9 5620.9 5002.1 5048.5 5114.5 5183.4 5218.9 5673.3 5675.8 5720.9 5724.4 5728.6 5426.6 5466.4 5467.7 5470.1 5479.5 5357.1 5463.3 5472.1 5517.4 5540.4 5567.4 5569.6 5570.9 5576.1 5608.0 5459.2 5529.1 5561.2 5565.7 5568.6 4201.5 4297.2 4304.2 4359.8 4377.5 3882.5 3893.8 3905.2 3913.5 3922.4 5108.2 5140.9 5160.3 5163.4 5231.5 5374.2 5472.5 5475.0 5531.9 5534.7 5099.3 5141.1 5145.3 5145.6 5165.8 4799.2 4803.1 4806.0 4818.4 4841.7 5560.7 5677.2 5716.1 5735.6 5830.8 5495.6 5496.9 5500.2 5502.0 5506.3 5563.9 5576.1 5578.4 5590.6 5686.4 5298.6 5363.7 5377.6 5441.7 5451.7 5572.9 5600.2 5600.2 5600.7 5601.4 5241.9 5381.4 5463.1 5487.8 5533.2 5286.8 5328.4 5338.8 5374.4 5381.1 5209.7 5210.9 5234.8 5235.3 5243.7 5227.0 5293.7 5306.0 5318.7 5378.8 5276.7 5302.0 5354.1 5359.0 5363.5 07:36:58 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | [#1] ext.html Cycles:180 Average:45426.23 Median:165229.41 stddev:79846.79 (48.3%) stddev-sans-first:79999.61 07:36:58 INFO - PROCESS | 11167 | Values: 524.7 530.0 532.8 547.5 555.1 28274.6 28843.9 35983.6 36386.8 36479.8 38171.0 38608.0 38669.2 38716.0 38717.8 8370.4 8530.7 8545.6 8546.5 8547.8 7643.7 7810.7 9974.1 10161.2 10164.9 9898.9 9902.7 9958.2 9958.8 9973.1 7628.2 7787.9 9856.9 9885.1 9964.0 7390.7 9947.5 10174.3 10179.4 10182.9 35582.1 35989.5 36017.1 36034.5 36046.0 3237.4 3242.1 3278.8 3502.4 3658.9 27839.9 28183.6 28800.4 29508.6 30695.8 3723.2 3804.1 3817.8 3955.1 4014.1 265588.0 265761.0 266556.0 267553.0 268120.0 52049.7 53178.2 57760.1 58095.4 58165.7 50565.0 50687.7 50867.0 50868.5 50891.5 16068.2 16351.7 16358.4 16359.8 16361.8 11566.4 11630.9 11638.8 11707.2 11710.9 19180.7 19449.9 19464.0 19543.6 19581.0 7235.1 7346.9 7428.3 7441.6 7451.9 874.4 897.4 939.4 960.8 1016.3 23452.6 23808.5 23935.6 24082.0 24122.6 1004.3 1008.9 1042.2 1055.8 1131.8 13153.8 13261.5 13386.0 13956.9 14001.4 327180.0 330370.0 330457.4 330512.0 332892.0 44947.6 44968.6 45002.3 45007.8 45129.1 1335.0 1361.3 1362.0 1363.0 1445.6 25167.5 26370.6 26389.3 26465.0 26466.7 42035.8 42465.0 42610.6 42634.6 42680.8 311533.0 313609.0 314191.0 314342.0 314426.0 27050.3 27965.9 28448.6 30695.4 31502.4 37392.3 37648.8 37674.6 38058.4 38067.8 31737.7 31894.4 32218.4 32325.4 32607.8 28066.6 30173.0 30503.8 31577.5 33346.0 32062.4 35949.5 36447.6 36461.6 36554.0 27584.4 29157.9 29197.9 29404.1 29521.6 22967.2 23644.4 24157.6 24388.6 24413.5 07:36:58 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | [#2] jquery.html Cycles:180 Average:27761.44 Median:353.98 stddev:76876.09 (21717.8%) stddev-sans-first:77064.20 07:36:58 INFO - PROCESS | 11167 | Values: 349.4 349.5 350.0 353.6 354.3 14106.4 14608.6 16286.9 16441.8 17181.7 15825.8 15878.0 16445.3 16505.7 16509.6 5476.6 5677.9 5683.4 5684.1 5684.7 4238.1 5648.1 5953.6 6593.9 6610.9 6434.4 6546.7 6553.4 6572.5 6594.3 6502.9 6530.7 6547.5 6549.2 6550.7 5833.1 5844.2 5992.0 6252.4 6262.1 21918.8 21947.3 22677.2 22683.0 22690.0 2163.6 2199.3 2294.5 2307.6 2349.3 14167.6 14219.1 14272.9 14279.7 14386.1 1901.9 1987.2 1992.5 1994.9 2007.7 67412.0 68060.3 68755.3 70721.6 70764.3 11876.3 15128.8 15195.8 15479.9 15695.9 24289.3 24362.8 24569.1 24582.4 24583.8 9138.7 9243.1 9279.1 9318.6 9344.1 7916.2 7963.4 7977.0 8010.8 8035.5 7161.6 7873.4 7892.6 7934.5 8017.4 2796.7 2961.6 2965.0 2989.5 3002.9 834.7 990.1 993.3 997.9 1008.5 14180.2 15519.5 15585.8 15998.8 16372.4 922.4 938.8 968.7 971.3 1018.0 8861.2 9204.6 9212.1 9253.2 9437.5 415975.0 420526.0 422680.0 456729.0 603299.0 78555.0 81460.1 81768.6 82017.0 82535.0 1067.5 1088.2 1091.7 1115.9 1140.2 15410.0 15532.1 15588.2 15714.4 15819.5 35714.3 36078.8 36289.6 36329.6 36423.0 46665.8 46834.3 47608.5 47798.3 48468.5 8947.0 9331.9 9429.2 9439.2 9440.5 11089.8 11318.5 11319.2 13464.5 16850.8 13724.4 13737.6 14087.0 14768.9 14782.4 13868.8 13968.8 14069.2 14182.6 14561.3 13854.8 14161.4 14496.6 14583.0 14980.9 9277.6 9351.2 9365.3 9487.8 9525.3 10137.9 12563.2 13667.7 13835.8 14693.5 07:36:58 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | [#3] mootools.html Cycles:180 Average:4884.70 Median:5772.12 stddev:2446.31 (42.4%) stddev-sans-first:2438.24 07:36:58 INFO - PROCESS | 11167 | Values: 1289.6 1416.5 1436.3 1542.6 1731.1 6281.3 6806.4 6915.2 6917.7 6918.2 6737.5 6853.8 6887.8 6894.4 6907.8 2161.6 2203.6 2205.8 2206.5 2209.2 2165.6 2203.1 2218.0 2221.1 2237.2 2179.9 2195.4 2215.6 2217.2 2235.5 2129.7 2160.4 2162.2 2163.7 2176.1 2175.4 2228.1 2232.9 2233.2 2233.4 6833.0 6901.4 6904.3 6910.1 6910.3 4290.5 4351.6 4354.9 4379.8 4380.7 2874.1 2918.4 2925.6 2932.6 2950.1 908.7 918.5 922.6 942.0 948.5 9667.5 9689.1 9694.4 9697.0 9706.8 3873.4 3950.3 3982.9 3994.6 4091.6 7585.8 7635.5 7656.4 7669.8 7674.0 4396.9 4431.0 4435.7 4440.2 4442.4 3507.8 3596.7 4041.3 4060.6 4113.9 3479.5 3494.9 3524.9 3541.6 3568.3 1114.1 1142.9 1149.2 1161.9 1174.5 1075.4 1091.1 1095.6 1203.6 1289.6 6517.1 6587.8 6626.1 6661.2 6675.5 497.6 504.2 508.1 516.0 516.5 5284.3 5313.9 5318.7 5319.6 5321.1 7967.1 8013.3 8122.1 8135.5 8218.5 8066.6 8088.1 8131.1 8154.1 8161.0 6451.3 6558.4 6648.9 6671.1 6711.1 6317.1 6365.1 6367.0 6368.3 6386.4 7375.9 7389.6 7477.1 7504.0 7645.5 7193.9 7315.7 7411.3 7639.8 7645.7 5448.5 5527.3 6045.7 6212.9 6317.1 6570.8 6598.8 6623.7 6626.6 6630.8 6132.2 6261.6 6358.3 6394.6 6412.5 6146.2 6197.5 6213.9 6314.3 6328.2 6100.0 6112.3 6132.0 6133.7 6136.2 5729.6 5742.4 5757.1 5758.0 5759.7 5676.9 5761.9 5764.4 5767.9 5776.3 07:36:58 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | [#4] prototype.html Cycles:180 Average:5284.92 Median:5942.14 stddev:1593.76 (26.8%) stddev-sans-first:1554.30 07:36:58 INFO - PROCESS | 11167 | Values: 333.5 336.6 338.7 343.6 344.3 5879.9 5896.3 5920.3 5960.2 5965.2 5633.6 5716.3 5794.5 5862.4 5880.9 4572.0 4577.4 4579.4 4580.3 4581.4 4347.7 4585.9 4595.6 4601.0 4602.7 4383.5 4415.2 4487.3 4495.4 4517.2 4473.7 4481.9 4489.2 4490.5 4504.7 4005.1 4010.1 4010.7 4019.2 4020.5 5508.4 5601.7 5607.3 5611.0 5616.2 5268.2 5278.6 5279.6 5283.9 5292.0 6253.1 6256.9 6263.2 6264.2 6267.3 4393.5 4395.6 4403.4 4403.5 4407.3 6350.6 6510.9 6529.7 6531.4 6537.7 4563.7 4572.0 4572.2 4572.6 4573.3 4623.3 4626.8 4631.1 4631.4 4632.1 5301.8 5304.8 5307.1 5308.2 5311.6 6137.6 6313.6 6334.2 6353.2 6364.1 1575.3 1585.6 1586.5 1587.5 1588.8 1044.7 1053.0 1058.3 1058.6 1059.8 5951.0 5961.3 5964.9 5966.2 5968.8 6485.7 6486.0 6489.7 6492.4 6496.4 5821.4 5883.4 5933.3 6021.6 6028.9 3515.1 3518.8 3543.3 3543.6 3546.9 6767.6 6787.4 6797.5 6798.6 6807.5 6544.7 6655.1 6701.2 6704.2 6707.2 6795.6 6804.2 6814.5 6818.8 6820.4 6573.8 6574.7 6579.3 6582.9 6583.8 6366.0 6433.0 6483.8 6486.0 6487.4 6739.6 6762.5 6767.9 6782.2 6791.1 4446.9 4448.1 4448.7 4451.2 4480.5 6413.2 6523.4 6552.4 6566.3 6580.1 6392.4 6395.6 6395.6 6408.0 6409.9 6378.3 6382.2 6386.2 6388.2 6388.9 6156.2 6197.8 6241.7 6262.9 6263.5 6416.1 6420.7 6424.9 6427.7 6437.3 6228.8 6251.2 6261.5 6268.7 6272.1 07:36:58 INFO - PROCESS | 11167 | 07:36:58 INFO - PROCESS | 11167 | [#5] yui.html Cycles:180 Average:13460.82 Median:46682.15 stddev:15695.98 (33.6%) stddev-sans-first:15710.93 07:36:58 INFO - PROCESS | 11167 | Values: 736.4 816.9 821.0 846.2 882.7 13817.8 13842.9 13949.7 13961.2 14038.2 12219.1 12285.3 12286.4 12300.7 12337.3 676.4 690.2 807.4 817.2 819.6 812.8 818.4 819.9 821.9 825.8 713.4 853.6 855.0 859.5 860.8 714.2 845.9 854.3 857.1 857.1 634.1 634.6 634.7 635.3 635.8 13382.5 13439.9 13491.6 13508.8 13512.0 10696.5 10898.2 11771.3 11794.4 12266.1 9918.8 10158.4 10158.7 10254.5 10457.3 3546.4 3593.6 3606.6 3609.3 3714.4 43699.6 44559.0 45139.5 45240.1 45248.0 9171.9 9182.8 9189.0 9290.2 9671.7 17001.3 17057.3 17625.5 17636.6 17653.5 7288.9 7413.7 7457.6 7483.3 7581.7 4211.9 4261.5 4282.6 4317.8 4369.0 2933.4 2958.4 2964.1 2964.4 2970.0 542.5 552.3 552.7 553.8 559.6 517.6 545.6 599.7 621.6 640.4 7855.1 7857.5 7915.0 8183.8 8550.6 428.0 477.8 516.7 532.1 668.5 3562.8 3616.0 3756.9 3855.4 3857.6 51748.0 51967.2 52011.5 52352.5 52610.5 49173.3 49503.8 50286.7 50292.2 50733.0 42921.4 43308.0 43519.8 44240.0 44411.8 7567.4 7762.2 7782.1 7808.0 8016.8 38514.4 39494.4 39705.6 42291.4 43582.0 46460.3 46904.0 50114.5 50920.5 50932.0 10696.9 10720.1 10868.9 10884.9 11101.6 11357.5 11518.8 11601.1 11634.5 11914.0 10217.3 10322.9 10364.0 10515.1 10781.0 10454.5 10624.6 10935.3 11046.3 11117.1 10024.1 10644.7 10662.5 10701.9 10740.4 8799.5 8904.2 9094.5 9203.3 9230.7 8314.5 8467.6 8487.7 8736.8 8904.6 07:36:58 INFO - PROCESS | 11167 | -------- Summary: end -------- 07:36:58 INFO - PROCESS | 11167 | 07:36:59 INFO - TEST-INFO | 11167: exit 0 07:36:59 INFO - TEST-OK | dromaeo_css | took 1113116ms 07:36:59 INFO - TEST-START | kraken 07:36:59 INFO - operating with platform_type : linux_ 07:36:59 INFO - Initialising browser for kraken test... 07:36:59 INFO - TEST-INFO | started process 11398 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDvU3ye/profile http://localhost:40045/getInfo.html) 07:37:03 INFO - PROCESS | 11398 | __metrics Screen width/height:1600/1200 07:37:03 INFO - PROCESS | 11398 | colorDepth:24 07:37:03 INFO - PROCESS | 11398 | Browser inner width/height: 1024/697 07:37:03 INFO - PROCESS | 11398 | __metrics 07:37:03 INFO - PROCESS | 11398 | 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:03 INFO - PROCESS | 11398 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:04 INFO - TEST-INFO | 11398: exit 0 07:37:04 INFO - Browser initialized. 07:37:04 INFO - Running cycle 1/1 for kraken test... 07:37:04 INFO - TEST-INFO | started process 11479 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDvU3ye/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:16 INFO - PROCESS | 11479 | RSS: Main: 148574208 07:37:16 INFO - PROCESS | 11479 | 07:37:19 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40045/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:19 INFO - PROCESS | 11479 | RSS: Main: 184946688 07:37:19 INFO - PROCESS | 11479 | 07:37:22 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40045/tests/kraken/driver.html?testName=audio-dft) 07:37:22 INFO - PROCESS | 11479 | RSS: Main: 174424064 07:37:22 INFO - PROCESS | 11479 | 07:37:25 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40045/tests/kraken/driver.html?testName=audio-fft) 07:37:26 INFO - PROCESS | 11479 | RSS: Main: 159096832 07:37:26 INFO - PROCESS | 11479 | 07:37:28 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40045/tests/kraken/driver.html?testName=audio-oscillator) 07:37:29 INFO - PROCESS | 11479 | RSS: Main: 163549184 07:37:29 INFO - PROCESS | 11479 | 07:37:31 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40045/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:31 INFO - PROCESS | 11479 | RSS: Main: 163270656 07:37:31 INFO - PROCESS | 11479 | 07:37:34 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40045/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:35 INFO - PROCESS | 11479 | RSS: Main: 164081664 07:37:35 INFO - PROCESS | 11479 | 07:37:38 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40045/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:39 INFO - PROCESS | 11479 | RSS: Main: 166301696 07:37:39 INFO - PROCESS | 11479 | 07:37:42 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40045/tests/kraken/driver.html?testName=json-parse-financial) 07:37:42 INFO - PROCESS | 11479 | RSS: Main: 164200448 07:37:42 INFO - PROCESS | 11479 | 07:37:44 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40045/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:44 INFO - PROCESS | 11479 | RSS: Main: 177463296 07:37:44 INFO - PROCESS | 11479 | 07:37:46 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:47 INFO - PROCESS | 11479 | RSS: Main: 174923776 07:37:47 INFO - PROCESS | 11479 | 07:37:49 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:49 INFO - PROCESS | 11479 | RSS: Main: 185102336 07:37:49 INFO - PROCESS | 11479 | 07:37:52 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:52 INFO - PROCESS | 11479 | RSS: Main: 192843776 07:37:52 INFO - PROCESS | 11479 | 07:37:55 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:55 INFO - PROCESS | 11479 | RSS: Main: 191037440 07:37:55 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | Cycle 1(1): loaded http://localhost:40045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40045/tests/kraken/driver.html?testName=ai-astar) 07:37:57 INFO - PROCESS | 11479 | RSS: Main: 248414208 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | __start_tp_report 07:37:57 INFO - PROCESS | 11479 | _x_x_mozilla_page_load 07:37:57 INFO - PROCESS | 11479 | _x_x_mozilla_page_load_details 07:37:57 INFO - PROCESS | 11479 | |i|pagename|runs| 07:37:57 INFO - PROCESS | 11479 | |0;ai-astar;109;111;105;110;110;111;100;110;109;102 07:37:57 INFO - PROCESS | 11479 | |1;audio-beat-detection;162;126;147;161;127;149;148;125;173;129 07:37:57 INFO - PROCESS | 11479 | |2;audio-dft;161;161;160;161;163;162;160;160;160;162 07:37:57 INFO - PROCESS | 11479 | |3;audio-fft;71;72;79;101;74;75;83;101;94;72 07:37:57 INFO - PROCESS | 11479 | |4;audio-oscillator;96;97;145;97;97;96;151;95;96;137 07:37:57 INFO - PROCESS | 11479 | |5;imaging-gaussian-blur;109;109;109;110;110;110;109;109;109;109 07:37:57 INFO - PROCESS | 11479 | |6;imaging-darkroom;146;145;146;146;146;147;145;145;145;145 07:37:57 INFO - PROCESS | 11479 | |7;imaging-desaturate;96;96;95;95;95;95;95;96;96;96 07:37:57 INFO - PROCESS | 11479 | |8;json-parse-financial;57;57;57;56;64;56;57;65;55;54 07:37:57 INFO - PROCESS | 11479 | |9;json-stringify-tinderbox;68;68;67;69;68;69;68;69;67;68 07:37:57 INFO - PROCESS | 11479 | |10;stanford-crypto-aes;85;85;86;87;87;87;93;93;94;87 07:37:57 INFO - PROCESS | 11479 | |11;stanford-crypto-ccm;123;115;125;113;121;119;114;119;122;116 07:37:57 INFO - PROCESS | 11479 | |12;stanford-crypto-pbkdf2;149;139;150;147;158;136;148;152;147;139 07:37:57 INFO - PROCESS | 11479 | |13;stanford-crypto-sha256-iterative;67;67;68;66;68;68;66;66;68;68 07:37:57 INFO - PROCESS | 11479 | __end_tp_report 07:37:57 INFO - PROCESS | 11479 | __start_cc_report 07:37:57 INFO - PROCESS | 11479 | _x_x_mozilla_cycle_collect,903 07:37:57 INFO - PROCESS | 11479 | __end_cc_report 07:37:57 INFO - PROCESS | 11479 | __startTimestamp1451403477866__endTimestamp 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | ------- Summary: start ------- 07:37:57 INFO - PROCESS | 11479 | Number of tests: 14 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#0] ai-astar Cycles:10 Average:107.70 Median:110.00 stddev:3.95 (3.6%) stddev-sans-first:4.16 07:37:57 INFO - PROCESS | 11479 | Values: 109.0 111.0 105.0 110.0 110.0 111.0 100.0 110.0 109.0 102.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:148.50 stddev:17.31 (11.7%) stddev-sans-first:17.20 07:37:57 INFO - PROCESS | 11479 | Values: 162.0 126.0 147.0 161.0 127.0 149.0 148.0 125.0 173.0 129.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 07:37:57 INFO - PROCESS | 11479 | Values: 161.0 161.0 160.0 161.0 163.0 162.0 160.0 160.0 160.0 162.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:12.06 (16.2%) stddev-sans-first:12.09 07:37:57 INFO - PROCESS | 11479 | Values: 71.0 72.0 79.0 101.0 74.0 75.0 83.0 101.0 94.0 72.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.00 stddev:23.45 (24.4%) stddev-sans-first:24.26 07:37:57 INFO - PROCESS | 11479 | Values: 96.0 97.0 145.0 97.0 97.0 96.0 151.0 95.0 96.0 137.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:37:57 INFO - PROCESS | 11479 | Values: 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:37:57 INFO - PROCESS | 11479 | Values: 146.0 145.0 146.0 146.0 146.0 147.0 145.0 145.0 145.0 145.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:37:57 INFO - PROCESS | 11479 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:3.68 (6.4%) stddev-sans-first:3.89 07:37:57 INFO - PROCESS | 11479 | Values: 57.0 57.0 57.0 56.0 64.0 56.0 57.0 65.0 55.0 54.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 07:37:57 INFO - PROCESS | 11479 | Values: 68.0 68.0 67.0 69.0 68.0 69.0 68.0 69.0 67.0 68.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:87.00 stddev:3.50 (4.0%) stddev-sans-first:3.49 07:37:57 INFO - PROCESS | 11479 | Values: 85.0 85.0 86.0 87.0 87.0 87.0 93.0 93.0 94.0 87.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:120.00 stddev:4.08 (3.4%) stddev-sans-first:4.02 07:37:57 INFO - PROCESS | 11479 | Values: 123.0 115.0 125.0 113.0 121.0 119.0 114.0 119.0 122.0 116.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:148.50 stddev:6.72 (4.5%) stddev-sans-first:7.07 07:37:57 INFO - PROCESS | 11479 | Values: 149.0 139.0 150.0 147.0 158.0 136.0 148.0 152.0 147.0 139.0 07:37:57 INFO - PROCESS | 11479 | 07:37:57 INFO - PROCESS | 11479 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 07:37:57 INFO - PROCESS | 11479 | Values: 67.0 67.0 68.0 66.0 68.0 68.0 66.0 66.0 68.0 68.0 07:37:57 INFO - PROCESS | 11479 | -------- Summary: end -------- 07:37:57 INFO - PROCESS | 11479 | 07:37:58 INFO - TEST-INFO | 11479: exit 0 07:37:58 INFO - TEST-OK | kraken | took 59094ms 07:37:58 INFO - TEST-START | v8_7 07:37:58 INFO - operating with platform_type : linux_ 07:37:58 INFO - Initialising browser for v8_7 test... 07:37:58 INFO - TEST-INFO | started process 11726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4LLnvs/profile http://localhost:40045/getInfo.html) 07:38:02 INFO - PROCESS | 11726 | __metrics Screen width/height:1600/1200 07:38:02 INFO - PROCESS | 11726 | colorDepth:24 07:38:02 INFO - PROCESS | 11726 | Browser inner width/height: 1024/697 07:38:02 INFO - PROCESS | 11726 | __metrics 07:38:03 INFO - PROCESS | 11726 | 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:03 INFO - PROCESS | 11726 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:03 INFO - TEST-INFO | 11726: exit 0 07:38:03 INFO - Browser initialized. 07:38:03 INFO - Running cycle 1/1 for v8_7 test... 07:38:03 INFO - TEST-INFO | started process 11812 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4LLnvs/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:15 INFO - PROCESS | 11812 | RSS: Main: 149319680 07:38:15 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:40045/tests/v8_7/run.html (next: http://localhost:40045/tests/v8_7/run.html) 07:38:37 INFO - PROCESS | 11812 | RSS: Main: 565202944 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | __start_tp_report 07:38:37 INFO - PROCESS | 11812 | _x_x_mozilla_page_load 07:38:37 INFO - PROCESS | 11812 | _x_x_mozilla_page_load_details 07:38:37 INFO - PROCESS | 11812 | |i|pagename|runs| 07:38:37 INFO - PROCESS | 11812 | |0;Richards;167.000668002672 07:38:37 INFO - PROCESS | 11812 | |1;DeltaBlue;190.98548510313216 07:38:37 INFO - PROCESS | 11812 | |2;Encrypt;280.74115665356544 07:38:37 INFO - PROCESS | 11812 | |3;Decrypt;5261.780104712042 07:38:37 INFO - PROCESS | 11812 | |4;RayTrace;1949.317738791423 07:38:37 INFO - PROCESS | 11812 | |5;Earley;780.64012490242 07:38:37 INFO - PROCESS | 11812 | |6;Boyer;12587.5 07:38:37 INFO - PROCESS | 11812 | |7;RegExp;25100 07:38:37 INFO - PROCESS | 11812 | |8;Splay;621.8905472636816 07:38:37 INFO - PROCESS | 11812 | |9;NavierStokes;4835.748792270531 07:38:37 INFO - PROCESS | 11812 | __end_tp_report 07:38:37 INFO - PROCESS | 11812 | __startTimestamp1451403517377__endTimestamp 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | ------- Summary: start ------- 07:38:37 INFO - PROCESS | 11812 | Number of tests: 10 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#0] Richards Cycles:1 Average:167.00 Median:167.00 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 167.0 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#1] DeltaBlue Cycles:1 Average:190.99 Median:190.99 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 191.0 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 280.7 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#3] Decrypt Cycles:1 Average:5261.78 Median:5261.78 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 5261.8 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#4] RayTrace Cycles:1 Average:1949.32 Median:1949.32 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 1949.3 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 780.6 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#6] Boyer Cycles:1 Average:12587.50 Median:12587.50 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 12587.5 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 25100.0 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#8] Splay Cycles:1 Average:621.89 Median:621.89 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 621.9 07:38:37 INFO - PROCESS | 11812 | 07:38:37 INFO - PROCESS | 11812 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:38:37 INFO - PROCESS | 11812 | Values: 4835.7 07:38:37 INFO - PROCESS | 11812 | -------- Summary: end -------- 07:38:37 INFO - PROCESS | 11812 | 07:38:38 INFO - TEST-INFO | 11812: exit 0 07:38:38 INFO - TEST-OK | v8_7 | took 39456ms 07:38:38 INFO - SUITE-END | took 1211s 07:38:38 INFO - Completed test suite (00:20:11) 07:38:38 INFO - Working with test: dromaeo_css 07:38:38 INFO - Generating results file: dromaeo_css 07:38:38 INFO - Working with test: kraken 07:38:38 INFO - Generating results file: kraken 07:38:38 INFO - javascript benchmark 07:38:38 INFO - Working with test: v8_7 07:38:38 INFO - Generating results file: v8_7 07:38:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:38:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:38:38 INFO - process_Request line: dromaeo_css 6828.99 graph.html#tests=[[72,1,35]] 07:38:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:38:38 INFO - process_Request line: kraken 1503.40 graph.html#tests=[[232,1,35]] 07:38:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:38:38 INFO - process_Request line: v8_7 19772.75 graph.html#tests=[[230,1,35]] 07:38:38 INFO - RETURN: dromaeo_css: 6828.99 07:38:38 INFO - RETURN: kraken: 1503.40 07:38:38 INFO - RETURN: v8_7: 19772.75 07:38:38 INFO - javascript benchmark 07:38:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3089.397567474343, 3144.0567829651127, 3178.3643271345736, 3184.2517008503014, 3208.887688930887, 4951.727654978975, 5098.439171691111, 5171.146760784471, 5178.378594568648, 5206.7656955437005, 5131.666441681288, 5142.871428214296, 5150.1759718445055, 5237.292965449663, 5252.264682944391, 4675.883102922428, 4721.669483136182, 4737.123632128068, 4740.834070807522, 4800.303955926389, 4809.110314591794, 4819.5180481951875, 4839.975800120995, 4846.87882802931, 4873.22028475444, 4692.976535117303, 4720.480747117815, 4780.0, 4796.0, 4807.591354734835, 4763.785629646674, 4766.165920963817, 4769.928451073237, 4781.497942716, 4802.207635740098, 4748.667593268473, 4748.9525104748855, 4752.168370535177, 4777.235642297216, 4783.4977327380475, 4866.562009419169, 4940.407151141886, 4963.354763880709, 5019.774110165052, 5045.091883461012, 5582.525485333711, 5585.385607583204, 5586.888262234773, 5588.1059030555325, 5619.494245517923, 5601.215829783793, 5608.990381731287, 5610.13042978339, 5610.887782244332, 5620.85947851307, 5002.099622068026, 5048.5203905628905, 5114.462981386938, 5183.377994640668, 5218.869528261824, 5673.3475650299915, 5675.77296908119, 5720.856978575485, 5724.398938111522, 5728.627639203439, 5426.565874730012, 5466.398696143421, 5467.699276539749, 5470.124780035176, 5479.4520547944885, 5357.142857142839, 5463.344398672185, 5472.069748142825, 5517.420670829505, 5540.36285827135, 5567.415421380778, 5569.554435645138, 5570.916436253459, 5576.052071147834, 5608.046632072557, 5459.208414779835, 5529.060059789846, 5561.193626924073, 5565.693886836182, 5568.554515638739, 4201.495820501559, 4297.183535128315, 4304.203722311382, 4359.80380882861, 4377.4965878923695, 3882.456456096149, 3893.824777885002, 3905.199434116056, 3913.4521167036637, 3922.3920292354733, 5108.157154069537, 5140.948590514047, 5160.277561141444, 5163.40620828602, 5231.503007214308, 5374.247605335257, 5472.480114389126, 5475.0418676731415, 5531.944680553223, 5534.667919924817, 5099.260607212008, 5141.074606570854, 5145.279660847485, 5145.588352931756, 5165.819196328111, 4799.208130658402, 4803.135435621622, 4806.038792241566, 4818.445878723922, 4841.733704646208, 5560.694161821058, 5677.233573467612, 5716.142578613241, 5735.627184233012, 5830.7959221427045, 5495.587830912617, 5496.862578435571, 5500.202470641814, 5501.972490137524, 5506.339239291311, 5563.916541251965, 5576.052071147834, 5578.358488773681, 5590.608657393944, 5686.43135686428, 5298.602604804578, 5363.704996225089, 5377.596680248918, 5441.673499590037, 5451.7274136292235, 5572.916406253828, 5600.215969764155, 5600.243967064557, 5600.747966341443, 5601.439856014366, 5241.868953276198, 5381.354237491526, 5463.125899856004, 5487.835364939058, 5533.170024496358, 5286.81496147633, 5328.387235467816, 5338.813141540028, 5374.408815030265, 5381.058314794817, 5209.661372010807, 5210.869728256824, 5234.842954711365, 5235.345581802275, 5243.711595862112, 5226.973865130803, 5293.682379057115, 5306.0, 5318.734063296897, 5378.838634840961, 5276.736163191748, 5301.973490132525, 5354.063038968243, 5359.0, 5363.517283444508], "unit": "score", "name": "dojo.html", "value": 5106.045566632187}, {"lowerIsBetter": false, "replicates": [524.7114087252011, 530.0485628297206, 532.7629205003774, 547.5482726750432, 555.0868820789801, 28274.57588136177, 28843.855780721093, 35983.640163598386, 36386.8180659097, 36479.81760091202, 38171.0, 38608.0, 38669.226615467676, 38716.0, 38717.806410967976, 8370.372222083353, 8530.74407767765, 8545.572721363938, 8546.52994085325, 8547.786305342384, 7643.656035478417, 7810.726624568141, 9974.052465015811, 10161.187105031617, 10164.898351016505, 9898.901010989906, 9902.702918912444, 9958.203343732484, 9958.751031224241, 9973.102420782128, 7628.160902300742, 7787.883181752279, 9856.901430985707, 9885.060919212663, 9963.950180249089, 7390.704371825121, 9947.502624868728, 10174.338667986558, 10179.440130792804, 10182.898171018269, 35582.11044723877, 35989.46015809765, 36017.118630509496, 36034.45948310778, 36046.0, 3237.352529494087, 3242.1084201844683, 3278.8196649184283, 3502.404591219499, 3658.9268214635827, 27839.86080069607, 28183.57724634132, 28800.423991520263, 29508.557371639443, 30695.846520767253, 3723.1995121049104, 3804.144067584799, 3817.8281977310808, 3955.149642826806, 4014.116894283253, 265588.0, 265761.0, 266555.9999999981, 267553.0, 268120.0, 52049.739751301, 53178.202326965125, 57760.133597996064, 58095.419045809, 58165.70917145387, 50565.0, 50687.7465612677, 50867.0, 50868.49131508637, 50891.491085089416, 16068.196590170444, 16351.67296654084, 16358.427455039255, 16359.836401635832, 16361.754573681405, 11566.363849988164, 11630.88369116315, 11638.76722465546, 11707.239029463057, 11710.94144529272, 19180.734856007944, 19449.932075020955, 19463.976256399066, 19543.609127817363, 19581.020948952497, 7235.095613048369, 7346.926530734624, 7428.33510222181, 7441.553506789502, 7451.85096298071, 874.3529787956993, 897.4211633496358, 939.4269495607674, 960.8174446855076, 1016.2885979814012, 23452.64821027686, 23808.523829523314, 23935.640965385533, 24082.0, 24122.638160427607, 1004.2919741582167, 1008.909198172168, 1042.2027149230844, 1055.8363453664695, 1131.7510147767478, 13153.802692959613, 13261.500619905726, 13386.0, 13956.860431395758, 14001.43994240219, 327180.0, 330370.0, 330457.3908521816, 330512.0, 332892.0, 44947.55052449499, 44968.55031449709, 45002.32496512555, 45007.77496112498, 45129.09741805145, 1334.9666258343618, 1361.2717196299932, 1361.9591412257648, 1363.0390574644853, 1445.6096853849401, 25167.49665006653, 26370.604440933017, 26389.340266492723, 26465.0, 26466.735332646425, 42035.7898210507, 42465.0, 42610.57389426066, 42634.57365426306, 42680.78659606682, 311533.0, 313609.0, 314191.0, 314342.0, 314426.0, 27050.32374190661, 27965.86017069983, 28448.57327140053, 30695.386092277582, 31502.369952600362, 37392.25215495621, 37648.811755941046, 37674.62325376711, 38058.429123562615, 38067.809660952626, 31737.740936782553, 31894.362112758077, 32218.35563288768, 32325.35349293048, 32607.836960815042, 28066.579001315404, 30173.0, 30503.847480762455, 31577.526337104504, 33346.0, 32062.35875282528, 35949.46075808813, 36447.63552364442, 36461.635383646884, 36554.0, 27584.44831103407, 29157.854210728812, 29197.85401072981, 29404.11787646374, 29521.557176642797, 22967.196148134735, 23644.408889777893, 24157.63763543513, 24388.6341704871, 24413.51172976495], "unit": "score", "name": "ext.html", "value": 17665.121893669868}, {"lowerIsBetter": false, "replicates": [349.3781069695941, 349.45136136266075, 349.97725147865384, 353.64105432985525, 354.3126334910272, 14106.365213565388, 14608.561743147722, 16286.918565407172, 16441.83558164418, 17181.65636687267, 15825.762613560777, 15878.0, 16445.25996330165, 16505.669886602293, 16509.58726031847, 5476.58925580581, 5677.886442271152, 5683.403242659523, 5684.147377893308, 5684.687342196177, 4238.088810905655, 5648.096304591266, 5953.583249172538, 6593.934060659404, 6610.93389066108, 6434.356564343575, 6546.738130474775, 6553.410193082622, 6572.474202063823, 6594.340565943416, 6502.869942601145, 6530.738770449177, 6547.508936829757, 6549.181352330958, 6550.67246637671, 5833.066709326487, 5844.152597873327, 5992.011318132503, 6252.437280644764, 6262.12330273762, 21918.78081219199, 21947.341579752632, 22677.2062977795, 22683.0, 22690.0, 2163.610550100981, 2199.3401979406112, 2294.460801711613, 2307.619242824932, 2349.283468542094, 14167.645808854759, 14219.146851188962, 14272.857271427256, 14279.714405711931, 14386.136831790021, 1901.9239230430767, 1987.1554589299635, 1992.4620352504742, 1994.8503862210248, 2007.749556531139, 67412.0, 68060.31939680639, 68755.3124468754, 70721.64639176823, 70764.29235707628, 11876.287422754489, 15128.848711512965, 15195.848041519665, 15479.922600387152, 15695.921520392325, 24289.27132186037, 24362.756372436404, 24569.14008009711, 24582.385440363778, 24583.754162458146, 9138.680146194984, 9243.075692430837, 9279.072092790668, 9318.580663870142, 9344.065593440602, 7916.247956444128, 7963.4425590209285, 7977.0, 8010.839783204303, 8035.517868927883, 7161.606111663908, 7873.409494287951, 7892.60536973149, 7934.523928564305, 8017.358611311198, 2796.7482926536304, 2961.5705722670523, 2964.955525667117, 2989.5067313892964, 3002.8948986785795, 834.6953362022939, 990.0594435286507, 993.2600212841479, 997.9351342162736, 1008.4554340655964, 14180.220087895059, 15519.456819011506, 15585.766213506806, 15998.76001859973, 16372.426965056165, 922.4050487435567, 938.779386844091, 968.6803354892868, 971.2666936462925, 1017.9694609161589, 8861.158189971942, 9204.59880335217, 9212.124848139416, 9253.167214950687, 9437.480938548446, 415975.0, 420526.0, 422680.0, 456729.0, 603299.0, 78555.0, 81460.14889478839, 81768.59115704383, 82017.0, 82535.0, 1067.5249513966367, 1088.2219213262556, 1091.6943255888364, 1115.8772535021142, 1140.2246472398683, 15410.0, 15532.068075915482, 15588.220588970733, 15714.449994250146, 15819.52541423759, 35714.28571428609, 36078.8196059018, 36289.637103629684, 36329.63670363263, 36422.99673517982, 46665.76667116643, 46834.29748553706, 47608.52391476041, 47798.283025755336, 48468.5153148464, 8947.0, 9331.906680933374, 9429.15137637616, 9439.150476457151, 9440.48077355752, 11089.778204435705, 11318.547258109913, 11319.207655464368, 13464.461421543028, 16850.831491684927, 13724.382402791698, 13737.587872363845, 14087.0, 14768.852311476749, 14782.408703651734, 13868.791968120688, 13968.79046814319, 14069.155850648995, 14182.581741826147, 14561.271936402925, 13854.792178117537, 14161.362738676578, 14496.565103046925, 14582.979191456496, 14980.925095374889, 9277.582508786985, 9351.158395744416, 9365.344425890122, 9487.762805929908, 9525.333226674065, 10137.949310253402, 12563.18339307942, 13667.658308541968, 13835.792463113263, 14693.485727999469], "unit": "score", "name": "jquery.html", "value": 9657.621685890457}, {"lowerIsBetter": false, "replicates": [1289.6389011076901, 1416.5467050543828, 1436.2818590704644, 1542.575791657294, 1731.0911771320064, 6281.340459251775, 6806.387425131743, 6915.1701795784575, 6917.654117294134, 6918.2389937107, 6737.461003119751, 6853.7943861684225, 6887.7589284374935, 6894.413974812134, 6907.827304317395, 2161.621716199663, 2203.6474164133742, 2205.834562407818, 2206.5476577301615, 2209.171560664751, 2165.577712346093, 2203.0857194264363, 2217.9556408871813, 2221.0782525252002, 2237.19460994042, 2179.8692078475265, 2195.407240045187, 2215.579039982398, 2217.2350539063996, 2235.4523141830273, 2129.7124888140056, 2160.384290477214, 2162.178372218563, 2163.697082408464, 2176.075168053571, 2175.369142948543, 2228.1198926424136, 2232.8995195216253, 2233.218373569254, 2233.3858188997992, 6832.965835170792, 6901.413379862718, 6904.3095690431055, 6910.101686780737, 6910.274421185753, 4290.4636920384955, 4351.608355248011, 4354.912901741947, 4379.846705365297, 4380.737155770632, 2874.1377586724107, 2918.4017276458276, 2925.648922129337, 2932.5601159825983, 2950.114965510338, 908.7410088124852, 918.5407296351824, 922.6171138977317, 942.0297093993198, 948.4972964328848, 9667.468289244089, 9689.1279784819, 9694.36986595869, 9696.95151524238, 9706.805863882682, 3873.360895452275, 3950.2692001979726, 3982.9402558961638, 3994.560598334181, 4091.6112969267874, 7585.810354741066, 7635.503692259986, 7656.425768067417, 7669.769906902802, 7674.0, 4396.934045989313, 4430.9587246996925, 4435.733855968652, 4440.156370289699, 4442.444694413199, 3507.7719948203285, 3596.6583174598372, 4041.2523683118716, 4060.573639767841, 4113.876583702494, 3479.478078288277, 3494.8776792812127, 3524.947125793115, 3541.592716837545, 3568.286342731464, 1114.0975809594254, 1142.948567314473, 1149.2127892393569, 1161.8838116188313, 1174.5301879248368, 1075.4138994248153, 1091.061686949223, 1095.5672509358758, 1203.6389083275158, 1289.6066699656508, 6517.087607734921, 6587.83530411734, 6626.105475760711, 6661.2006559213205, 6675.499337549606, 497.572088004316, 504.16560592219935, 508.1209507551882, 515.9767810448539, 516.468037920942, 5284.339457567804, 5313.867153321198, 5318.70747108905, 5319.627626066215, 5321.095413779667, 7967.123616402191, 8013.318867896294, 8122.06596241428, 8135.511869287861, 8218.506889586644, 8066.637001334954, 8088.069871964799, 8131.14622964592, 8154.062282837431, 8161.0, 6451.29035806061, 6558.37695418944, 6648.900266496006, 6671.066050752898, 6711.127553418122, 6317.052442133717, 6365.077063825626, 6367.044943258548, 6368.267649220399, 6386.361363863576, 7375.889361659687, 7389.630518474162, 7477.140128885248, 7503.962480187564, 7645.541267523967, 7193.928060719326, 7315.670794814139, 7411.295926886937, 7639.847203056019, 7645.732399365996, 5448.536874365724, 5527.336719593674, 6045.667488288186, 6212.875742485216, 6317.052442133717, 6570.77002304917, 6598.769043083469, 6623.701933412912, 6626.56927299724, 6630.801075967729, 6132.233470816148, 6261.624302541862, 6358.268799088164, 6394.6482943436695, 6412.519061070345, 6146.170267014075, 6197.5351848610635, 6213.850437669045, 6314.336994615683, 6328.177336946352, 6100.0, 6112.32764395925, 6132.0, 6133.662648554372, 6136.171616831671, 5729.570282228766, 5742.425757424224, 5757.107648314518, 5758.049921762862, 5759.7408116634015, 5676.858078548069, 5761.913571296518, 5764.423557644202, 5767.942320576908, 5776.306843178845], "unit": "score", "name": "mootools.html", "value": 4022.7217990204385}, {"lowerIsBetter": false, "replicates": [333.46645367412134, 336.6179386396439, 338.70701842905896, 343.5791155834103, 344.32168627803236, 5879.8824023519555, 5896.321922978858, 5920.3191632962225, 5960.19537362456, 5965.164876917235, 5633.577481688869, 5716.28546431696, 5794.478496935275, 5862.384449632791, 5880.9411905880925, 4572.0, 4577.375031863682, 4579.427571553556, 4580.3358513015755, 4581.40441742573, 4347.652187824982, 4585.908281834361, 4595.58639722425, 4600.97699511502, 4602.6778125531055, 4383.539728328511, 4415.227335216325, 4487.326900964848, 4495.3931219285305, 4517.186906356855, 4473.686841921067, 4481.865544033684, 4489.1919454498175, 4490.461144662645, 4504.729716217037, 4005.0588111793704, 4010.1177740896956, 4010.6791456683395, 4019.216252830699, 4020.4773379460776, 5508.394076651565, 5601.691906945116, 5607.271054762855, 5611.046122159243, 5616.185653080322, 5268.1834315681135, 5278.630495865291, 5279.5512381447625, 5283.894322113575, 5292.047431462335, 6253.062040693887, 6256.906146407808, 6263.217097862767, 6264.185655864754, 6267.310595834455, 4393.538678438782, 4395.582419670126, 4403.405540252057, 4403.471583409979, 4407.294832826765, 6350.587211831216, 6510.869782604369, 6529.738810447577, 6531.412172904414, 6537.705803238866, 4563.703359281636, 4572.0, 4572.222722137245, 4572.565606267399, 4573.314002899525, 4623.306504024356, 4626.791794369262, 4631.143238500888, 4631.421072365954, 4632.050429661911, 5301.840944771663, 5304.814331498379, 5307.071262529042, 5308.23030660552, 5311.601629877775, 6137.631742095488, 6313.621182729051, 6334.239891212992, 6353.174087368612, 6364.07720880479, 1575.2911189964332, 1585.5718955882078, 1586.5240427871593, 1587.515807678669, 1588.809342878862, 1044.6865940217904, 1053.0206907576028, 1058.3226734889677, 1058.576569372242, 1059.750958524746, 5951.0, 5961.254843144607, 5964.940350596526, 5966.194563733927, 5968.820935371946, 6485.67571621417, 6486.0, 6489.70796314167, 6492.415682588589, 6496.350364963466, 5821.359650438449, 5883.382244864313, 5933.2880054393745, 6021.578489505692, 6028.909566356509, 3515.1212196950764, 3518.7888726676483, 3543.326767914088, 3543.6456354364873, 3546.858125674944, 6767.593944363354, 6787.389134977876, 6797.456203503708, 6798.626075565891, 6807.523473356818, 6544.6727663617585, 6655.134832471747, 6701.1623547056615, 6704.229013663394, 6707.228668703064, 6795.558288711317, 6804.21751498584, 6814.48891333152, 6818.829529261709, 6820.420264277592, 6573.83063589024, 6574.737010519717, 6579.276279609335, 6582.901256481061, 6583.80248592543, 6365.96817015912, 6433.002884552901, 6483.805485835433, 6486.0, 6487.448566871869, 6739.5619284746335, 6762.4928130389435, 6767.898481522682, 6782.220044694924, 6791.0832037676255, 4446.911061778811, 4448.110377924363, 4448.6663500238255, 4451.198784218872, 4480.529544397791, 6413.230412350548, 6523.412892839668, 6552.3775241352, 6566.277709451861, 6580.1116849224745, 6392.360763923756, 6395.616263024233, 6395.6482393468805, 6407.97472404413, 6409.9038514423255, 6378.266499352449, 6382.20222472191, 6386.233651961795, 6388.201474815648, 6388.936110638834, 6156.2006319116035, 6197.783077592263, 6241.719122639402, 6262.937370626418, 6263.467605253604, 6416.101745755504, 6420.7431702731365, 6424.871502570016, 6427.742890284337, 6437.324080971431, 6228.844278893064, 6251.156093927261, 6261.530385221035, 6268.717907694256, 6272.121902933684], "unit": "score", "name": "prototype.html", "value": 4766.366218814041}, {"lowerIsBetter": false, "replicates": [736.4145504324061, 816.9183081691831, 820.9589520523972, 846.2130218896424, 882.6601758323047, 13817.792733109012, 13842.930785346072, 13949.721005579882, 13961.162330260191, 14038.227897465635, 12219.083568732358, 12285.324307163102, 12286.385680715974, 12300.692482687937, 12337.321447320393, 676.3642176354224, 690.2097098821846, 807.4146243973101, 817.207308910356, 819.5615345790004, 812.7886749445128, 818.3739439328918, 819.8524265632184, 821.9136990615989, 825.8100636853527, 713.4470785141505, 853.5860107847689, 854.9572521373938, 859.4757198109148, 860.8149247911698, 714.2357677285307, 845.8562044452427, 854.2781349759443, 857.0700789643245, 857.0957639690156, 634.1470721879065, 634.6065439427584, 634.7270673610345, 635.2504045226631, 635.8156134720972, 13382.531611393651, 13439.86560134396, 13491.595252142353, 13508.797368039488, 13512.0, 10696.51865666047, 10898.237123401364, 11771.293722376598, 11794.410279486077, 12266.141370104096, 9918.80162396748, 10158.441285729283, 10158.695239142837, 10254.53854576546, 10457.320274182153, 3546.4325707886615, 3593.586737525192, 3606.6393360663988, 3609.2781443711365, 3714.3871261242134, 43699.56300437018, 44559.0, 45139.54860451386, 45240.09519809618, 45247.99999999967, 9171.908280917105, 9182.816343673223, 9188.954055229815, 9290.16388525036, 9671.661491847752, 17001.31994720222, 17057.317707291568, 17625.471235862944, 17636.559086022953, 17653.470395888144, 7288.854222915618, 7413.703451861865, 7457.589832559262, 7483.251674832473, 7581.734639287599, 4211.894702632459, 4261.509926358446, 4282.614564689193, 4317.84887528935, 4369.038811461473, 2933.3839893622153, 2958.393529326483, 2964.0663191094736, 2964.3626620276746, 2970.0, 542.4792199488456, 552.3234038303046, 552.71258945349, 553.8144721518256, 559.5775189731727, 517.5626595526774, 545.5954841787219, 599.7301214453513, 621.59906860075, 640.4140211706236, 7855.096663883613, 7857.528548287121, 7914.960425197953, 8183.754487365389, 8550.572471376407, 427.9679024073207, 477.77067007836433, 516.6925679220858, 532.0927818070181, 668.5320275806955, 3562.7684200526883, 3615.9819200903826, 3756.9060773480883, 3855.4024126260474, 3857.5756666766633, 51748.0, 51967.22049169266, 52011.47988520142, 52352.47647523552, 52610.473895260555, 49173.262401064014, 49503.75248123809, 50286.74856625694, 50292.245616315784, 50733.0, 42921.35617965733, 43308.0, 43519.78240108779, 44240.0, 44411.777941110086, 7567.394608431202, 7762.184970578008, 7782.105057918412, 7807.960960195162, 8016.799580010546, 38514.422283665204, 39494.40758388684, 39705.60294397019, 42291.36562951496, 43582.0, 46460.30309545292, 46904.0, 50114.498855010985, 50920.49079509306, 50932.0, 10696.946515267375, 10720.127668062974, 10868.945655271673, 10884.891151088388, 11101.611443599435, 11357.48891299877, 11518.827217591575, 11601.071914246671, 11634.534618615498, 11914.046876250053, 10217.33587316822, 10322.896771032194, 10364.0, 10515.053645171665, 10781.0, 10454.477276136315, 10624.575016999233, 10935.343879367263, 11046.281991670516, 11117.055050320814, 10024.147947424259, 10644.680659580225, 10662.466876656292, 10701.94649026781, 10740.409277489813, 8799.47203167812, 8904.154105359981, 9094.545272736468, 9203.309751768511, 9230.723078307661, 8314.542700151549, 8467.61895714682, 8487.660493580188, 8736.78158046054, 8904.55477226149], "unit": "score", "name": "yui.html", "value": 6071.773521847283}], "name": "dromaeo_css", "value": 6828.9880335399575}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 110.0, 110.0, 111.0, 100.0, 110.0, 109.0, 102.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [162.0, 126.0, 147.0, 161.0, 127.0, 149.0, 148.0, 125.0, 173.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 163.0, 162.0, 160.0, 160.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 79.0, 101.0, 74.0, 75.0, 83.0, 101.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 145.0, 97.0, 97.0, 96.0, 151.0, 95.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 56.0, 64.0, 56.0, 57.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 69.0, 68.0, 69.0, 68.0, 69.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 87.0, 87.0, 87.0, 93.0, 93.0, 94.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [123.0, 115.0, 125.0, 113.0, 121.0, 119.0, 114.0, 119.0, 122.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [149.0, 139.0, 150.0, 147.0, 158.0, 136.0, 148.0, 152.0, 147.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 66.0, 68.0, 68.0, 66.0, 66.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1503.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.000668002672], "unit": "score", "name": "Richards", "value": 211.38837599999997}, {"lowerIsBetter": false, "replicates": [190.98548510313216], "unit": "score", "name": "DeltaBlue", "value": 346.19384800000006}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5261.780104712042], "unit": "score", "name": "Decrypt", "value": 50.58763283582091}, {"lowerIsBetter": false, "replicates": [1949.317738791423], "unit": "score", "name": "RayTrace", "value": 379.61435700000015}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12587.5], "unit": "score", "name": "Boyer", "value": 52.946415094339656}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [621.8905472636816], "unit": "score", "name": "Splay", "value": 131.03752799999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19772.753592159228}]} 07:38:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19772.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1503.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6828.99"}}} 07:38:38 INFO - Return code: 0 07:38:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:38:38 INFO - # TBPL SUCCESS # 07:38:38 INFO - Running post-action listener: _resource_record_post_action 07:38:38 INFO - Running post-run listener: _resource_record_post_run 07:38:39 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 2351104; Write bytes: 562978816; Read time: 900; Write time: 607780 07:38:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241180672; Read time: 0; Write time: 375308 07:38:39 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 2351104; Write bytes: 321798144; Read time: 900; Write time: 232472 07:38:39 INFO - Running post-run listener: _upload_blobber_files 07:38:39 INFO - Blob upload gear active. 07:38:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:38:39 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:39 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:39 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:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:41 INFO - (blobuploader) - INFO - Done attempting. 07:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:38:41 INFO - (blobuploader) - INFO - Done attempting. 07:38:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:38:41 INFO - Return code: 0 07:38:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:38:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:38:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca1d6d5eef08e529a4c72284fd3d26c3852572f80bff76227ee3a12bad443026592df276588ff6417344d208e025e2d5bfe5883d9d1e2fe3fa92f4ca4970c3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d4111077bb8182f456e3bfdf553ce4e325891a738832de0176212848902f81a7b003b91a9bbee02ab0f14a287d668684a5eb5f51e22ecab5af8d9fe21f7ad96"} 07:38:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:38:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:38:41 INFO - Contents: 07:38:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca1d6d5eef08e529a4c72284fd3d26c3852572f80bff76227ee3a12bad443026592df276588ff6417344d208e025e2d5bfe5883d9d1e2fe3fa92f4ca4970c3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d4111077bb8182f456e3bfdf553ce4e325891a738832de0176212848902f81a7b003b91a9bbee02ab0f14a287d668684a5eb5f51e22ecab5af8d9fe21f7ad96"} 07:38:41 INFO - Copying logs to upload dir... 07:38:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.171306 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-29 07:38:41.817473) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 07:38:41.821525) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca1d6d5eef08e529a4c72284fd3d26c3852572f80bff76227ee3a12bad443026592df276588ff6417344d208e025e2d5bfe5883d9d1e2fe3fa92f4ca4970c3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d4111077bb8182f456e3bfdf553ce4e325891a738832de0176212848902f81a7b003b91a9bbee02ab0f14a287d668684a5eb5f51e22ecab5af8d9fe21f7ad96"} 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.011387 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca1d6d5eef08e529a4c72284fd3d26c3852572f80bff76227ee3a12bad443026592df276588ff6417344d208e025e2d5bfe5883d9d1e2fe3fa92f4ca4970c3a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d4111077bb8182f456e3bfdf553ce4e325891a738832de0176212848902f81a7b003b91a9bbee02ab0f14a287d668684a5eb5f51e22ecab5af8d9fe21f7ad96"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 07:38:41.849849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:38:41.850185) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1451401724.753133-1663088830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 07:38:41.934867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 07:38:41.935216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 07:38:41.935554) ========= ========= Total master_lag: 0.25 =========