builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1451964984.79 results: success (0) buildid: 20160104173013 builduid: 2ed6be3568894ab2b93a66220a79c1ed revision: c38424a542eb0e9149d4adabfe1db57bd390f398 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.793444) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.793903) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.794217) ========= 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=db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006319 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.820460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.820763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.836401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.836744) ========= 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=db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.885580) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.885862) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.886275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.886560) ========= 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=db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 19:36: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2016-01-04 19:36:25 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097756 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.997162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:24.997476) ========= 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=db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021680 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:25.050190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-04 19:36:25.050592) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c38424a542eb0e9149d4adabfe1db57bd390f398 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c38424a542eb0e9149d4adabfe1db57bd390f398 --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=db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 19:36:25,143 truncating revision to first 12 chars 2016-01-04 19:36:25,144 Setting DEBUG logging. 2016-01-04 19:36:25,144 attempt 1/10 2016-01-04 19:36:25,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c38424a542eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 19:36:26,162 unpacking tar archive at: fx-team-c38424a542eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.286066 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-04 19:36:26.354655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:26.355146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:26.388808) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:26.389519) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 19:36:26.390278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-04 19:36:26.390840) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:36:26 INFO - MultiFileLogger online at 20160104 19:36:26 in /builds/slave/test-pgo 19:36:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:36:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:36:26 INFO - {'append_to_log': False, 19:36:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:36:26 INFO - 'blob_upload_branch': 'Fx-Team', 19:36:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:36:26 INFO - 'branch': 'Fx-Team', 19:36:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:26 INFO - 'config_files': ('talos/linux_config.py',), 19:36:26 INFO - 'default_actions': ('clobber', 19:36:26 INFO - 'read-buildbot-config', 19:36:26 INFO - 'download-and-extract', 19:36:26 INFO - 'populate-webroot', 19:36:26 INFO - 'create-virtualenv', 19:36:26 INFO - 'install', 19:36:26 INFO - 'run-tests'), 19:36:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:26 INFO - 'download_minidump_stackwalk': True, 19:36:26 INFO - 'download_symbols': 'ondemand', 19:36:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:26 INFO - 'installer_path': 'installer.exe', 19:36:26 INFO - 'log_level': 'info', 19:36:26 INFO - 'log_name': 'talos', 19:36:26 INFO - 'log_to_console': True, 19:36:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:36:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:36:26 INFO - 'opt_config_files': (), 19:36:26 INFO - 'pip_index': False, 19:36:26 INFO - 'sps_profile': False, 19:36:26 INFO - 'sps_profile_interval': 0, 19:36:26 INFO - 'suite': 'dromaeojs', 19:36:26 INFO - 'system_bits': '32', 19:36:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:26 INFO - 'title': 'talos-linux64-ix-031', 19:36:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:26 INFO - 'use_talos_json': True, 19:36:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:36:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:26 INFO - 'work_dir': 'build'} 19:36:26 INFO - ##### 19:36:26 INFO - ##### Running clobber step. 19:36:26 INFO - ##### 19:36:26 INFO - Running pre-action listener: _resource_record_pre_action 19:36:26 INFO - Running main action method: clobber 19:36:26 INFO - rmtree: /builds/slave/test-pgo/build 19:36:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:36:27 INFO - Running post-action listener: _resource_record_post_action 19:36:27 INFO - ##### 19:36:27 INFO - ##### Running read-buildbot-config step. 19:36:27 INFO - ##### 19:36:27 INFO - Running pre-action listener: _resource_record_pre_action 19:36:27 INFO - Running main action method: read_buildbot_config 19:36:27 INFO - Using buildbot properties: 19:36:27 INFO - { 19:36:27 INFO - "project": "", 19:36:27 INFO - "product": "firefox", 19:36:27 INFO - "script_repo_revision": "production", 19:36:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:36:27 INFO - "repository": "", 19:36:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:36:27 INFO - "buildid": "20160104173013", 19:36:27 INFO - "pgo_build": "True", 19:36:27 INFO - "basedir": "/builds/slave/test-pgo", 19:36:27 INFO - "buildnumber": 869, 19:36:27 INFO - "slavename": "talos-linux64-ix-031", 19:36:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:36:27 INFO - "platform": "ubuntu64_hw", 19:36:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:36:27 INFO - "branch": "fx-team", 19:36:27 INFO - "repo_path": "integration/fx-team", 19:36:27 INFO - "revision": "c38424a542eb0e9149d4adabfe1db57bd390f398", 19:36:27 INFO - "stage_platform": "linux64-pgo", 19:36:27 INFO - "builduid": "2ed6be3568894ab2b93a66220a79c1ed", 19:36:27 INFO - "slavebuilddir": "test" 19:36:27 INFO - } 19:36:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:36:27 INFO - Running post-action listener: _resource_record_post_action 19:36:27 INFO - ##### 19:36:27 INFO - ##### Running download-and-extract step. 19:36:27 INFO - ##### 19:36:27 INFO - Running pre-action listener: _resource_record_pre_action 19:36:27 INFO - Running main action method: download_and_extract 19:36:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:27 INFO - https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:36:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/test_packages.json 19:36:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/test_packages.json 19:36:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:36:27 INFO - Downloaded 1302 bytes. 19:36:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:36:27 INFO - Using the following test package requirements: 19:36:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:36:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:27 INFO - u'jsshell-linux-x86_64.zip'], 19:36:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:36:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:36:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:36:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:36:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:36:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:27 INFO - https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:36:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:36:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:36:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:29 INFO - Downloaded 23198177 bytes. 19:36:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:36:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:36:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:36:30 INFO - Return code: 0 19:36:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:30 INFO - https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:36:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:36:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:36:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:36:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:31 INFO - Downloaded 23198177 bytes. 19:36:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:36:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:36:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:36:32 INFO - Return code: 0 19:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:32 INFO - https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:36:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:36:34 INFO - Downloaded 11132285 bytes. 19:36:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:36:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:36:34 INFO - Return code: 0 19:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:34 INFO - https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:36:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:36:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:36:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:36:36 INFO - Downloaded 55017827 bytes. 19:36:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:36:36 INFO - mkdir: /builds/slave/test-pgo/properties 19:36:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:36:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:36:36 INFO - Contents: 19:36:36 INFO - build_url:https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:36:36 INFO - Running post-action listener: _resource_record_post_action 19:36:36 INFO - Running post-action listener: set_extra_try_arguments 19:36:36 INFO - ##### 19:36:36 INFO - ##### Running populate-webroot step. 19:36:36 INFO - ##### 19:36:36 INFO - Running pre-action listener: _resource_record_pre_action 19:36:36 INFO - Running main action method: populate_webroot 19:36:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:36 INFO - '--tppagecycles', 19:36:36 INFO - '7'], 19:36:36 INFO - 'tests': ['tsvgm']}}, 19:36:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:36:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:36:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:36:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:36 INFO - 'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:36 INFO - 'tests': ['damp', 'tps']}, 19:36:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:36 INFO - 'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['damp', 'tps']}, 19:36:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:36:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:36 INFO - 'other': {'tests': ['a11yr', 19:36:36 INFO - 'ts_paint', 19:36:36 INFO - 'tpaint', 19:36:36 INFO - 'sessionrestore', 19:36:36 INFO - 'sessionrestore_no_auto_restore']}, 19:36:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['a11yr', 19:36:36 INFO - 'ts_paint', 19:36:36 INFO - 'tpaint', 19:36:36 INFO - 'sessionrestore', 19:36:36 INFO - 'sessionrestore_no_auto_restore']}, 19:36:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['a11yr', 19:36:36 INFO - 'ts_paint', 19:36:36 INFO - 'tpaint', 19:36:36 INFO - 'sessionrestore', 19:36:36 INFO - 'sessionrestore_no_auto_restore']}, 19:36:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['a11yr', 19:36:36 INFO - 'ts_paint', 19:36:36 INFO - 'tpaint', 19:36:36 INFO - 'sessionrestore', 19:36:36 INFO - 'sessionrestore_no_auto_restore']}, 19:36:36 INFO - 'other_l64': {'tests': ['a11yr', 19:36:36 INFO - 'ts_paint', 19:36:36 INFO - 'tpaint', 19:36:36 INFO - 'sessionrestore', 19:36:36 INFO - 'sessionrestore_no_auto_restore']}, 19:36:36 INFO - 'other_nol64': {'tests': ['a11yr', 19:36:36 INFO - 'ts_paint', 19:36:36 INFO - 'tpaint', 19:36:36 INFO - 'sessionrestore', 19:36:36 INFO - 'sessionrestore_no_auto_restore']}, 19:36:36 INFO - 'svgr': {'tests': ['tsvgx', 19:36:36 INFO - 'tsvgr_opacity', 19:36:36 INFO - 'tart', 19:36:36 INFO - 'tscrollx', 19:36:36 INFO - 'cart']}, 19:36:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['tsvgx', 19:36:36 INFO - 'tsvgr_opacity', 19:36:36 INFO - 'tart', 19:36:36 INFO - 'tscrollx', 19:36:36 INFO - 'cart']}, 19:36:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:36 INFO - 'tests': ['tp5o']}, 19:36:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:36 INFO - 'talos_options': ['--e10s'], 19:36:36 INFO - 'tests': ['tp5o']}, 19:36:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:36 INFO - 'talos_options': ['--xperf_path', 19:36:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:36 INFO - 'tests': ['tp5n']}, 19:36:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:36 INFO - 'talos_options': ['--e10s', 19:36:36 INFO - '--xperf_path', 19:36:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:36 INFO - 'tests': ['tp5n']}}, 19:36:36 INFO - 'talos.zip': {'path': '', 19:36:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:36 INFO - Running post-action listener: _resource_record_post_action 19:36:36 INFO - ##### 19:36:36 INFO - ##### Running create-virtualenv step. 19:36:36 INFO - ##### 19:36:36 INFO - Running pre-action listener: _resource_record_pre_action 19:36:36 INFO - Running main action method: create_virtualenv 19:36:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:36:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:36:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:36:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:36 INFO - Using real prefix '/usr' 19:36:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:36:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:39 INFO - Installing pip.................done. 19:36:39 INFO - Return code: 0 19:36:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:36:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:36:39 INFO - Using env: {'DISPLAY': ':0', 19:36:39 INFO - 'HOME': '/home/cltbld', 19:36:39 INFO - 'LANG': 'en_US.UTF-8', 19:36:39 INFO - 'LANGUAGE': 'en_US:en', 19:36:39 INFO - 'LOGNAME': 'cltbld', 19:36:39 INFO - 'MAIL': '/var/mail/cltbld', 19:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:39 INFO - 'MOZ_NO_REMOTE': '1', 19:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:39 INFO - 'NO_EM_RESTART': '1', 19:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:39 INFO - 'SHELL': '/bin/bash', 19:36:39 INFO - 'SHLVL': '1', 19:36:39 INFO - 'TERM': 'linux', 19:36:39 INFO - 'TMOUT': '86400', 19:36:39 INFO - 'USER': 'cltbld', 19:36:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:39 INFO - '_': '/tools/buildbot/bin/python'} 19:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:36:39 INFO - Cleaning up... 19:36:39 INFO - Return code: 0 19:36:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:36:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:36:39 INFO - Using env: {'DISPLAY': ':0', 19:36:39 INFO - 'HOME': '/home/cltbld', 19:36:39 INFO - 'LANG': 'en_US.UTF-8', 19:36:39 INFO - 'LANGUAGE': 'en_US:en', 19:36:39 INFO - 'LOGNAME': 'cltbld', 19:36:39 INFO - 'MAIL': '/var/mail/cltbld', 19:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:39 INFO - 'MOZ_NO_REMOTE': '1', 19:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:39 INFO - 'NO_EM_RESTART': '1', 19:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:39 INFO - 'SHELL': '/bin/bash', 19:36:39 INFO - 'SHLVL': '1', 19:36:39 INFO - 'TERM': 'linux', 19:36:39 INFO - 'TMOUT': '86400', 19:36:39 INFO - 'USER': 'cltbld', 19:36:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:39 INFO - '_': '/tools/buildbot/bin/python'} 19:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:39 INFO - Downloading/unpacking psutil>=0.7.1 19:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:36:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:36:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:41 INFO - Installing collected packages: psutil 19:36:41 INFO - Running setup.py install for psutil 19:36:41 INFO - building 'psutil._psutil_linux' extension 19:36:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:36:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:36:41 INFO - building 'psutil._psutil_posix' extension 19:36:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:36:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:36:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:41 INFO - Successfully installed psutil 19:36:41 INFO - Cleaning up... 19:36:41 INFO - Return code: 0 19:36:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:41 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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:36:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:36:41 INFO - Using env: {'DISPLAY': ':0', 19:36:41 INFO - 'HOME': '/home/cltbld', 19:36:41 INFO - 'LANG': 'en_US.UTF-8', 19:36:41 INFO - 'LANGUAGE': 'en_US:en', 19:36:41 INFO - 'LOGNAME': 'cltbld', 19:36:41 INFO - 'MAIL': '/var/mail/cltbld', 19:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:41 INFO - 'MOZ_NO_REMOTE': '1', 19:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:41 INFO - 'NO_EM_RESTART': '1', 19:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:41 INFO - 'SHELL': '/bin/bash', 19:36:41 INFO - 'SHLVL': '1', 19:36:41 INFO - 'TERM': 'linux', 19:36:41 INFO - 'TMOUT': '86400', 19:36:41 INFO - 'USER': 'cltbld', 19:36:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:41 INFO - '_': '/tools/buildbot/bin/python'} 19:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:36:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:36:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:36:43 INFO - Installing collected packages: mozsystemmonitor 19:36:43 INFO - Running setup.py install for mozsystemmonitor 19:36:43 INFO - Successfully installed mozsystemmonitor 19:36:43 INFO - Cleaning up... 19:36:43 INFO - Return code: 0 19:36:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:36:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:36:44 INFO - Using env: {'DISPLAY': ':0', 19:36:44 INFO - 'HOME': '/home/cltbld', 19:36:44 INFO - 'LANG': 'en_US.UTF-8', 19:36:44 INFO - 'LANGUAGE': 'en_US:en', 19:36:44 INFO - 'LOGNAME': 'cltbld', 19:36:44 INFO - 'MAIL': '/var/mail/cltbld', 19:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:44 INFO - 'MOZ_NO_REMOTE': '1', 19:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:44 INFO - 'NO_EM_RESTART': '1', 19:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:44 INFO - 'SHELL': '/bin/bash', 19:36:44 INFO - 'SHLVL': '1', 19:36:44 INFO - 'TERM': 'linux', 19:36:44 INFO - 'TMOUT': '86400', 19:36:44 INFO - 'USER': 'cltbld', 19:36:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:44 INFO - '_': '/tools/buildbot/bin/python'} 19:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:44 INFO - Downloading/unpacking blobuploader==1.2.4 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:45 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:36:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:36:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:36:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:46 INFO - Downloading docopt-0.6.1.tar.gz 19:36:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:36:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:46 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:46 INFO - Running setup.py install for blobuploader 19:36:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:36:46 INFO - Running setup.py install for requests 19:36:47 INFO - Running setup.py install for docopt 19:36:47 INFO - Successfully installed blobuploader requests docopt 19:36:47 INFO - Cleaning up... 19:36:47 INFO - Return code: 0 19:36:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:47 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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:36:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:47 INFO - Using env: {'DISPLAY': ':0', 19:36:47 INFO - 'HOME': '/home/cltbld', 19:36:47 INFO - 'LANG': 'en_US.UTF-8', 19:36:47 INFO - 'LANGUAGE': 'en_US:en', 19:36:47 INFO - 'LOGNAME': 'cltbld', 19:36:47 INFO - 'MAIL': '/var/mail/cltbld', 19:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:47 INFO - 'MOZ_NO_REMOTE': '1', 19:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:47 INFO - 'NO_EM_RESTART': '1', 19:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:47 INFO - 'SHELL': '/bin/bash', 19:36:47 INFO - 'SHLVL': '1', 19:36:47 INFO - 'TERM': 'linux', 19:36:47 INFO - 'TMOUT': '86400', 19:36:47 INFO - 'USER': 'cltbld', 19:36:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:47 INFO - '_': '/tools/buildbot/bin/python'} 19:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:36:47 INFO - Running setup.py (path:/tmp/pip-y8CBvG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:36:47 INFO - Running setup.py (path:/tmp/pip-DPDvow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:36:47 INFO - Running setup.py (path:/tmp/pip-gggMMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:36:47 INFO - Running setup.py (path:/tmp/pip-dAv7sv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:36:47 INFO - Running setup.py (path:/tmp/pip-Hay_0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:36:47 INFO - Running setup.py (path:/tmp/pip-dG6RbR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:36:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:36:47 INFO - Running setup.py (path:/tmp/pip-9JhK5y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:36:48 INFO - Running setup.py (path:/tmp/pip-VYNFZA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:36:48 INFO - Running setup.py (path:/tmp/pip-uEVS6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:36:48 INFO - Running setup.py (path:/tmp/pip-kl15_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:36:48 INFO - Running setup.py (path:/tmp/pip-Vt6DdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:36:48 INFO - Running setup.py (path:/tmp/pip-Q7V_wp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:36:48 INFO - Running setup.py (path:/tmp/pip-UEOksP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:36:48 INFO - Running setup.py (path:/tmp/pip-abh8kl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:36:48 INFO - Running setup.py (path:/tmp/pip-lns7XR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:36:48 INFO - Running setup.py (path:/tmp/pip-PYbht5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:36:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:36:48 INFO - Running setup.py (path:/tmp/pip-b2fpRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:36:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:48 INFO - Running setup.py install for manifestparser 19:36:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:36:48 INFO - Running setup.py install for mozcrash 19:36:48 INFO - Running setup.py install for mozdebug 19:36:48 INFO - Running setup.py install for mozdevice 19:36:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Running setup.py install for mozfile 19:36:49 INFO - Running setup.py install for mozhttpd 19:36:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Running setup.py install for mozinfo 19:36:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Running setup.py install for mozInstall 19:36:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Running setup.py install for mozleak 19:36:49 INFO - Running setup.py install for mozlog 19:36:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Running setup.py install for moznetwork 19:36:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:36:49 INFO - Running setup.py install for mozprocess 19:36:49 INFO - Running setup.py install for mozprofile 19:36:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:36:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:36:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:36:50 INFO - Running setup.py install for mozrunner 19:36:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:36:50 INFO - Running setup.py install for mozscreenshot 19:36:50 INFO - Running setup.py install for moztest 19:36:50 INFO - Running setup.py install for mozversion 19:36:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:36:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:50 INFO - Cleaning up... 19:36:50 INFO - Return code: 0 19:36:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:36:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:50 INFO - Using env: {'DISPLAY': ':0', 19:36:50 INFO - 'HOME': '/home/cltbld', 19:36:50 INFO - 'LANG': 'en_US.UTF-8', 19:36:50 INFO - 'LANGUAGE': 'en_US:en', 19:36:50 INFO - 'LOGNAME': 'cltbld', 19:36:50 INFO - 'MAIL': '/var/mail/cltbld', 19:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:50 INFO - 'MOZ_NO_REMOTE': '1', 19:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:50 INFO - 'NO_EM_RESTART': '1', 19:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:50 INFO - 'SHELL': '/bin/bash', 19:36:50 INFO - 'SHLVL': '1', 19:36:50 INFO - 'TERM': 'linux', 19:36:50 INFO - 'TMOUT': '86400', 19:36:50 INFO - 'USER': 'cltbld', 19:36:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:50 INFO - '_': '/tools/buildbot/bin/python'} 19:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:36:50 INFO - Running setup.py (path:/tmp/pip-3TRyMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:36:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:36:50 INFO - Running setup.py (path:/tmp/pip-V8YaF0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:36:50 INFO - Running setup.py (path:/tmp/pip-kefzQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:36:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:36:50 INFO - Running setup.py (path:/tmp/pip-eQXjWW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:36:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:36:50 INFO - Running setup.py (path:/tmp/pip-8tk1qQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:36:51 INFO - Running setup.py (path:/tmp/pip-J2PAF3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:36:51 INFO - Running setup.py (path:/tmp/pip-NcG_8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:36:51 INFO - Running setup.py (path:/tmp/pip-3nOqfK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:36:51 INFO - Running setup.py (path:/tmp/pip-AWhTOH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:36:51 INFO - Running setup.py (path:/tmp/pip-bKm_Ui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:36:51 INFO - Running setup.py (path:/tmp/pip-AhF7zG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:36:51 INFO - Running setup.py (path:/tmp/pip-KxLjMg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:36:51 INFO - Running setup.py (path:/tmp/pip-jwnNvA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:36:51 INFO - Running setup.py (path:/tmp/pip-EjI29D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:36:51 INFO - Running setup.py (path:/tmp/pip-X0sPpc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:36:51 INFO - Running setup.py (path:/tmp/pip-yovP31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:36:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:36:51 INFO - Running setup.py (path:/tmp/pip-04ubCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:53 INFO - Downloading blessings-1.5.1.tar.gz 19:36:53 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:36:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:53 INFO - Installing collected packages: blessings 19:36:53 INFO - Running setup.py install for blessings 19:36:53 INFO - Successfully installed blessings 19:36:53 INFO - Cleaning up... 19:36:53 INFO - Return code: 0 19:36:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:36:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:36:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:36:54 INFO - Reading from file tmpfile_stdout 19:36:54 INFO - Current package versions: 19:36:54 INFO - argparse == 1.2.1 19:36:54 INFO - blessings == 1.5.1 19:36:54 INFO - blobuploader == 1.2.4 19:36:54 INFO - docopt == 0.6.1 19:36:54 INFO - manifestparser == 1.1 19:36:54 INFO - mozInstall == 1.12 19:36:54 INFO - mozcrash == 0.16 19:36:54 INFO - mozdebug == 0.1 19:36:54 INFO - mozdevice == 0.47 19:36:54 INFO - mozfile == 1.2 19:36:54 INFO - mozhttpd == 0.7 19:36:54 INFO - mozinfo == 0.9 19:36:54 INFO - mozleak == 0.1 19:36:54 INFO - mozlog == 3.1 19:36:54 INFO - moznetwork == 0.27 19:36:54 INFO - mozprocess == 0.22 19:36:54 INFO - mozprofile == 0.28 19:36:54 INFO - mozrunner == 6.11 19:36:54 INFO - mozscreenshot == 0.1 19:36:54 INFO - mozsystemmonitor == 0.0 19:36:54 INFO - moztest == 0.7 19:36:54 INFO - mozversion == 1.4 19:36:54 INFO - psutil == 3.1.1 19:36:54 INFO - requests == 1.2.3 19:36:54 INFO - wsgiref == 0.1.2 19:36:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:54 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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:36:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:54 INFO - Using env: {'DISPLAY': ':0', 19:36:54 INFO - 'HOME': '/home/cltbld', 19:36:54 INFO - 'LANG': 'en_US.UTF-8', 19:36:54 INFO - 'LANGUAGE': 'en_US:en', 19:36:54 INFO - 'LOGNAME': 'cltbld', 19:36:54 INFO - 'MAIL': '/var/mail/cltbld', 19:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:54 INFO - 'MOZ_NO_REMOTE': '1', 19:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:54 INFO - 'NO_EM_RESTART': '1', 19:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:54 INFO - 'SHELL': '/bin/bash', 19:36:54 INFO - 'SHLVL': '1', 19:36:54 INFO - 'TERM': 'linux', 19:36:54 INFO - 'TMOUT': '86400', 19:36:54 INFO - 'USER': 'cltbld', 19:36:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:54 INFO - '_': '/tools/buildbot/bin/python'} 19:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:36:54 INFO - Cleaning up... 19:36:54 INFO - Return code: 0 19:36:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:54 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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:36:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:36:54 INFO - Using env: {'DISPLAY': ':0', 19:36:54 INFO - 'HOME': '/home/cltbld', 19:36:54 INFO - 'LANG': 'en_US.UTF-8', 19:36:54 INFO - 'LANGUAGE': 'en_US:en', 19:36:54 INFO - 'LOGNAME': 'cltbld', 19:36:54 INFO - 'MAIL': '/var/mail/cltbld', 19:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:54 INFO - 'MOZ_NO_REMOTE': '1', 19:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:54 INFO - 'NO_EM_RESTART': '1', 19:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:54 INFO - 'SHELL': '/bin/bash', 19:36:54 INFO - 'SHLVL': '1', 19:36:54 INFO - 'TERM': 'linux', 19:36:54 INFO - 'TMOUT': '86400', 19:36:54 INFO - 'USER': 'cltbld', 19:36:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:54 INFO - '_': '/tools/buildbot/bin/python'} 19:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:54 INFO - Downloading/unpacking jsonschema 19:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:36:56 INFO - Downloading/unpacking functools32 (from jsonschema) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:36:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:56 INFO - warning: no files found matching '*.txt' 19:36:56 INFO - no previously-included directories found matching 'build' 19:36:56 INFO - no previously-included directories found matching 'dist' 19:36:56 INFO - no previously-included directories found matching '.git*' 19:36:56 INFO - Installing collected packages: jsonschema, functools32 19:36:56 INFO - Running setup.py install for functools32 19:36:56 INFO - warning: no files found matching '*.txt' 19:36:56 INFO - no previously-included directories found matching 'build' 19:36:56 INFO - no previously-included directories found matching 'dist' 19:36:56 INFO - no previously-included directories found matching '.git*' 19:36:56 INFO - Successfully installed jsonschema functools32 19:36:56 INFO - Cleaning up... 19:36:56 INFO - Return code: 0 19:36:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:36: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')]} 19:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:56 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 0x7fa6a14fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, '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': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:36:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:36:56 INFO - Using env: {'DISPLAY': ':0', 19:36:56 INFO - 'HOME': '/home/cltbld', 19:36:56 INFO - 'LANG': 'en_US.UTF-8', 19:36:56 INFO - 'LANGUAGE': 'en_US:en', 19:36:56 INFO - 'LOGNAME': 'cltbld', 19:36:56 INFO - 'MAIL': '/var/mail/cltbld', 19:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:56 INFO - 'MOZ_NO_REMOTE': '1', 19:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:56 INFO - 'NO_EM_RESTART': '1', 19:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:36:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:36:56 INFO - 'SHELL': '/bin/bash', 19:36:56 INFO - 'SHLVL': '1', 19:36:56 INFO - 'TERM': 'linux', 19:36:56 INFO - 'TMOUT': '86400', 19:36:56 INFO - 'USER': 'cltbld', 19:36:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:56 INFO - '_': '/tools/buildbot/bin/python'} 19:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:56 INFO - Downloading/unpacking flake8 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:36:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:36:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:36:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:36:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:36:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:36:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:36:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:59 INFO - no previously-included directories found matching 'docs/_build' 19:36:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:36:59 INFO - Running setup.py install for pep8 19:36:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:59 INFO - no previously-included directories found matching 'docs/_build' 19:36:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:36:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:36:59 INFO - Cleaning up... 19:36:59 INFO - Return code: 0 19:36:59 INFO - Running post-action listener: _resource_record_post_action 19:36:59 INFO - Running post-action listener: _start_resource_monitoring 19:36:59 INFO - Starting resource monitoring. 19:36:59 INFO - ##### 19:36:59 INFO - ##### Running install step. 19:36:59 INFO - ##### 19:36:59 INFO - Running pre-action listener: _resource_record_pre_action 19:36:59 INFO - Running main action method: install 19:36:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:36:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:36:59 INFO - Reading from file tmpfile_stdout 19:36:59 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:36:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:36:59 INFO - Reading from file tmpfile_stdout 19:36:59 INFO - Output received: 19:36:59 INFO - Usage: mozinstall [options] installer 19:36:59 INFO - Options: 19:36:59 INFO - -h, --help show this help message and exit 19:36:59 INFO - -d DEST, --destination=DEST 19:36:59 INFO - Directory to install application into. [default: 19:36:59 INFO - "/builds/slave/test-pgo"] 19:36:59 INFO - --app=APP Application being installed. [default: firefox] 19:36:59 INFO - mkdir: /builds/slave/test-pgo/build/application 19:36:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:36:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:37:15 INFO - Reading from file tmpfile_stdout 19:37:15 INFO - Output received: 19:37:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:37:15 INFO - Running post-action listener: _resource_record_post_action 19:37:15 INFO - ##### 19:37:15 INFO - ##### Running run-tests step. 19:37:15 INFO - ##### 19:37:15 INFO - Running pre-action listener: _resource_record_pre_action 19:37:15 INFO - Running main action method: run_tests 19:37:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:37:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:37:15 INFO - Python 2.7.3 19:37:15 INFO - Return code: 0 19:37:15 INFO - grabbing minidump binary from tooltool 19:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:15 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 0x2bde840>, '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 0x2b4b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:37:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:37:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:37:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:15 INFO - Return code: 0 19:37:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:37:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:37:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:37:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:37:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:37:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:37:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:37:16 INFO - Return code: 0 19:37:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:37:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 19:37:16 INFO - Using env: {'DISPLAY': ':0', 19:37:16 INFO - 'HOME': '/home/cltbld', 19:37:16 INFO - 'LANG': 'en_US.UTF-8', 19:37:16 INFO - 'LANGUAGE': 'en_US:en', 19:37:16 INFO - 'LOGNAME': 'cltbld', 19:37:16 INFO - 'MAIL': '/var/mail/cltbld', 19:37:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:37:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:16 INFO - 'MOZ_NO_REMOTE': '1', 19:37:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:37:16 INFO - 'NO_EM_RESTART': '1', 19:37:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:37:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:37:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:37:16 INFO - 'SHELL': '/bin/bash', 19:37:16 INFO - 'SHLVL': '1', 19:37:16 INFO - 'TERM': 'linux', 19:37:16 INFO - 'TMOUT': '86400', 19:37:16 INFO - 'USER': 'cltbld', 19:37:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092', 19:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:16 INFO - '_': '/tools/buildbot/bin/python'} 19:37:16 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:37:16 INFO - mozversion application_buildid: 20160104173013 19:37:16 INFO - mozversion application_changeset: c38424a542eb0e9149d4adabfe1db57bd390f398 19:37:16 INFO - mozversion application_display_name: Nightly 19:37:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:16 INFO - mozversion application_name: Firefox 19:37:16 INFO - mozversion application_remotingname: firefox 19:37:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:37:16 INFO - mozversion application_vendor: Mozilla 19:37:16 INFO - mozversion application_version: 46.0a1 19:37:16 INFO - mozversion platform_buildid: 20160104173013 19:37:16 INFO - mozversion platform_changeset: c38424a542eb0e9149d4adabfe1db57bd390f398 19:37:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:37:16 INFO - mozversion platform_version: 46.0a1 19:37:16 INFO - using testdate: 1451965036 19:37:16 INFO - actual date: 1451965036 19:37:16 INFO - starting webserver on 'localhost:48033' 19:37:16 INFO - SUITE-START | Running 3 tests 19:37:16 INFO - TEST-START | dromaeo_css 19:37:16 INFO - operating with platform_type : linux_ 19:37:16 INFO - Initialising browser for dromaeo_css test... 19:37:16 INFO - TEST-INFO | started process 5445 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgVGaLk/profile http://localhost:48033/getInfo.html) 19:37:20 INFO - PROCESS | 5445 | __metrics Screen width/height:1600/1200 19:37:20 INFO - PROCESS | 5445 | colorDepth:24 19:37:20 INFO - PROCESS | 5445 | Browser inner width/height: 1024/697 19:37:20 INFO - PROCESS | 5445 | __metrics 19:37:20 INFO - PROCESS | 5445 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:37:20 INFO - PROCESS | 5445 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:21 INFO - TEST-INFO | 5445: exit 0 19:37:21 INFO - Browser initialized. 19:37:21 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:21 INFO - TEST-INFO | started process 5538 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgVGaLk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:33 INFO - PROCESS | 5538 | RSS: Main: 150147072 19:37:33 INFO - PROCESS | 5538 | 19:38:25 INFO - PROCESS | 5538 | 1451965105244 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] 19:40:33 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48033/tests/dromaeo/cssquery-ext.html) 19:40:34 INFO - PROCESS | 5538 | RSS: Main: 272244736 19:40:34 INFO - PROCESS | 5538 | 19:43:37 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-ext.html (next: http://localhost:48033/tests/dromaeo/cssquery-jquery.html) 19:43:37 INFO - PROCESS | 5538 | RSS: Main: 238297088 19:43:37 INFO - PROCESS | 5538 | 19:46:39 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48033/tests/dromaeo/cssquery-mootools.html) 19:46:40 INFO - PROCESS | 5538 | RSS: Main: 231841792 19:46:40 INFO - PROCESS | 5538 | 19:49:42 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48033/tests/dromaeo/cssquery-prototype.html) 19:49:42 INFO - PROCESS | 5538 | RSS: Main: 214351872 19:49:42 INFO - PROCESS | 5538 | 19:52:45 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48033/tests/dromaeo/cssquery-yui.html) 19:52:45 INFO - PROCESS | 5538 | RSS: Main: 215986176 19:52:45 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:48033/tests/dromaeo/cssquery-yui.html (next: http://localhost:48033/tests/dromaeo/cssquery-dojo.html) 19:55:48 INFO - PROCESS | 5538 | RSS: Main: 259694592 19:55:48 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | __start_tp_report 19:55:48 INFO - PROCESS | 5538 | _x_x_mozilla_page_load 19:55:48 INFO - PROCESS | 5538 | _x_x_mozilla_page_load_details 19:55:48 INFO - PROCESS | 5538 | |i|pagename|runs| 19:55:48 INFO - PROCESS | 5538 | |0;dojo.html;3137.5921130253073;3165.8733650653976;3218.4206842768294;3227;3251.512273159026;5074.822381216658;5184.792608295664;5193.039287731773;5203.95920815837;5248.291480650107;5189.558887494568;5232.8691782705455;5239.423663397033;5240.240165176047;5335.039692855285;4664.090502352043;4721.362616046824;4737.668363214576;4760.214564596838;4815.783289751952;4780.760961951906;4807.086653535835;4818.277258411232;4856.247281671329;4878.365812444377;4655.860324190246;4675.462321832982;4739.881502962454;4757.215059515176;4789.832355867528;4709.081729062834;4728.40894888139;4744.5492678195515;4757.809687612491;4783.3064205690325;4722.83470078549;4744.240921452551;4754.619630429557;4765.189917713997;4788.9521104788855;4909.7790599423115;4951.108800415924;5001.149804533202;5073.340465739467;5085.288059671649;5592.86017849553;5597.216389705403;5601.60788744788;5601.747921343549;5603.719814009283;5525.475079867406;5612.69130197839;5628.296462942132;5629.662220266797;5633.63381380209;5203.531682148625;5227.3465816772905;5253.159494480903;5281.445448227881;5306.097963346202;5762.769489220468;5779.826605201851;5780.132980053026;5784.045632470679;5834.358220595731;5424.403315635277;5565.833025009256;5568.749406276727;5571.1086226203615;5571.442855714477;5488.643238189505;5492.286002819608;5513.283273174462;5557.749901254453;5610.663360198319;5585.609007369445;5630.071038278638;5636.126400407943;5638.859028524238;5640.210370548127;5426.077566813651;5573.637713548606;5654.886902261932;5656.8020119295625;5660.518855897212;4327.350897365421;4372.147431250939;4435.933460998088;4439.667024973075;4476.843310484118;3891.2412079644196;3895.844166233319;3903.512060992376;3935.173613541131;3937.448757173998;5078.060558796635;5172.069027575073;5182.300389447451;5194.428612852583;5243.213517972258;5600.747966341524;5631.6902570359025;5666.206731057655;5666.97166514173;5703.458171473703;5172.9741351293005;5200.713960732196;5204.453532379046;5206.062908676475;5253.711045892436;4637.420322459692;4654.092451971833;4739.644526660514;4789.114013907369;4796.112719146969;5719.857003574861;5768.423157684198;5792.21805056312;5801.9129713054335;5828.825135245949;5595.384507704068;5616.045272303636;5620.887582248414;5622.212890195294;5627.7467513961155;5653.349864765604;5739.62692424991;5754.280714910468;5755.223044888887;5818.272715910512;5442.836714898559;5449.754761035683;5461;5484.287042684426;5493.6978466183145;5472.91790623133;5515.61390702647;5515.834524964257;5529.585281104014;5549.112142057252;5362.436944120811;5406.756695948613;5411.972940135274;5460.31746031746;5471.206675032177;5399.541039011571;5447.972760136174;5504.22940788298;5517.779288828402;5549.139883317931;5348.732563371894;5349.839504814861;5357.410684824588;5359.196120581944;5364.195370694427;5367.919481207863;5400.945990540202;5436.238926550365;5441.455854414527;5502.394736579053;5311.893762124813;5350.491703288181;5374.892502150014;5383.353997520166;5426.864328391822 19:55:48 INFO - PROCESS | 5538 | |1;ext.html;527.85747848081;552.488947723356;562.1287005142029;565.6916980245766;571.0805602979203;28883.378659414473;29505.557416638767;29597;37198.81400593;37687.434688479625;41030.794846025725;41302.38046429306;41538.376924346085;41608.167836643326;41659;8274.213949674771;8458.407911446202;8458.66165353385;8489;8531.317494600447;7507.324340809326;7650.08199016116;7654.693812247503;10159.746006349826;10392.792144157112;10070.848937265946;10172.13536849365;10174.59301627934;10178.643747468841;10178.949105254464;10074.294799364048;10160.59357625694;10174.422964440524;10181.33821301613;10197.082262596401;7246.130464344313;7366.668499917463;7368.410527157815;10093.192544596415;10348.430836304;36506.452403213974;37267.44098838492;37276.44085338722;37297.627023729685;37342.81328593367;3003.8197708137363;3051.7711171662213;3124.4376012317775;3125.2030732163153;3329.8002119872885;30140.698593014007;30885.227869303224;31789.26887674928;32844;33312;3633.7819730815972;3651.1602331463914;3661.8169091545315;3867.245887052026;3944.3534378232303;273198;276957;277831;278378;278402;53326;60207.69896150491;60562;60625;60683.08975365373;47948;64474;65450.67274663596;65680.67159664171;65701.67149164224;13027.934860325639;13050.869491305155;13057.151285166434;13060.804087938688;13091.541796037283;9580.808383832424;9594.952025239829;9607.423554586747;9637.036296370306;9646.565904534313;19274.71087933682;19329;19352.32266870653;19387.8061219386;19970.90014549918;7386.482946193715;7761.573113478813;7781.182975787574;7909.802254943673;7926.603669816486;943.5659596585648;948.3977674176809;1042.1142029275056;1048.1614708233383;1069.8020866139789;27888.302792430353;28337.71662283392;28647.14058578246;28849;28893.27766805847;1039.5581877701945;1074.7957888001254;1088.0153461117702;1093.327603523827;1102.0081926266264;14628.634284142981;14658.853411465961;14863.405463781544;15098.094114353175;15115.848841511444;303117;304974;305241;307892;309303;51694.22458663123;52267.73866130721;52316.47683523116;52455.47544524506;52542.21186682203;1299.311364976564;1308.084340961312;1309.0509380698918;1310.9541166059141;1318.347418028063;25752.61371079398;26794.464110718065;28383.716162838107;28636.42727145487;29323.266918327212;41353;42001.78999104985;42041.369379459946;42071.36892946547;42092;220764;223109;223332;223437;224180;26611.068612598465;27958.860205698842;28210.85894570596;31611.525827112153;32064.51903221407;36572.81713591415;36577.81711091428;37056;37329.81335093307;37571.24857502889;31715.84142079275;31724.682753173096;31808.6819131815;32113.518297226026;32223.516647250777;29022.564661530516;33335.83332083324;33500.039929723374;33858.32283354369;34193.31613367768;31299;31744.6825531751;32025.35949281048;32085.518717218794;32535;29155.562666559596;29946.550801737554;30752.231194220323;30781.846090769403;30898.845505772326;23715;23854.16510422127;24301.51396972086;24350;24526.754732452446 19:55:48 INFO - PROCESS | 5538 | |2;jquery.html;354.3213307396084;355.1618181092621;355.8149762123694;357.46915829992474;358.1297447203296;14012.579622611313;14354.354054067591;16160.353585856566;16352.91823540882;17010.234539445722;15684.764728529053;16545;16725.581860453465;17068.402605908796;17086.82913170868;5194.428612852583;5325.174597937306;5327.121025030865;5330.200469929503;5333.546648534879;3859.07382228266;3996.4005399190064;5351.518363347298;5378.381486129087;5583.218349431083;5673.063944449161;5728.828135155952;5758.280214973129;5771.451712087366;5783.248177736909;5569.498745112939;5715.857103572403;5733.999999999979;5775.27809023872;5787.88424231513;5102.438731739506;5105.336306280197;5114.974425127888;5116.616253780981;5119.718415487147;18974.905125474423;20229;20361.592768144554;20425.795742042537;20427.5914481711;2002.8898410587412;2046.1508473983429;2060.1347434077575;2070.565181311926;2165.761766205716;12780.552680656132;13154.802677959839;13160.14459060158;13288.468461261538;13536.729265414735;1774.7692799936056;1816.2553353125156;1848.898310592917;1879.821416965386;1899.7435346228222;58291.70854145745;60324.69837650828;60324.99999999956;61304.38695613076;62085.37914620886;9541.904580954102;9672.70981870545;9832.852507212398;9845.55694993727;9910.504474776233;12220.450079746433;12269.57056503018;12290.75418491643;12296.385180740926;12299.631011069681;7121.537100088478;7161.319674630901;7169.856602867913;7223.674934627849;7334.156571994289;6917.446604271646;6939.583624982416;6970.965145174343;6998.895016574756;7026.297370262932;4033.3344998075577;4188.68584856137;4254.808533615995;4279.743215407086;4335.501417337046;1708.180073564696;1754.9385771498191;1759.2874885671324;1779.6084861330487;1843.4008947092248;442.09150196346815;443.10271699808146;462.6715032327018;948.4262021476907;982.9066238707311;10459.738506537398;10809.35143891369;16208.918955405383;16846.24191911367;17592.912035439742;807.6890397197121;943.565959658551;950.7575568230058;992.513668302541;1016.7000734783256;9002.819943601091;9030.909690903007;9123.954380228057;9245.214156796614;9472;525497;533137;536261;537911;578128;67800.6609966947;68669.31330686629;69604.6519767408;77638;81700.59149704213;1105.8230683090828;1130.2822707580744;1134.177721152158;1134.8127558952845;1148.936808475542;15157.696846062796;15223.391064357302;15398.769018464507;15408;15764.921175394049;34131.317373652884;34580.48129278113;35206.516578796334;35399.82300088483;36002.8199858999;46017;46949.530504694514;47452.525474746195;48560;51018.74490627523;9098.499582523025;9366.250699943852;9419;9439.339246252972;9441.905580944103;11238.887611123784;16089.436869709503;16859.15704214809;17247.102818690186;17340.566485837953;14207.431702731776;14214.715705685621;14332.856671433152;14605.342759575633;14678.266086695408;13869.722605548035;14000.859991399955;14072;14110.36503357331;14616.342264597906;11399.601013964471;11586.362750048827;12551.435185416496;12584.182028168507;14666.19335936491;8740.694075707319;8763.386562940534;8808.691695790616;8883.111688831064;9307.162355388047;13292.800607991081;13352.265625390697;13472.932635336761;13571.728565428833;14428.278586070865 19:55:48 INFO - PROCESS | 5538 | |3;mootools.html;1281.0840249221806;1437.769956806911;1441.106513961344;1573.9606509837254;1786.7319902014697;6873.106496155506;7481.064866891638;7583.50707204032;7587.20334364892;7598.164201937796;7408.185099639036;7645.350145237648;7651.923480765205;7665.1951545087795;7676.1939996300425;1917.1468696430095;1950.4148755373403;2191;2254.233560589399;2290.896909639062;2237.4518243030398;2244.62963611004;2247.763984781599;2248.123231939545;2249.966250506244;2121.66053431451;2192.090282532747;2197.8681279123302;2199.8790066546335;2202.735671719396;2195.242641288753;2209.2709405896017;2229.687843701875;2264.671622614728;2266.5693518231647;2234.597772400967;2242.275635103357;2269.6822444857735;2273.1589311954517;2332.055517515409;7581;7593.9240607593765;7616.695332186706;7704.768856934301;7716.189800070968;4380.452443444569;4476.104779044172;4492.550744925514;4496.4829044659955;4496.775161241925;2891.8698658560415;2961.452131355706;3009.969900300991;3025.9243518911985;3027.6820933802073;911.0707078779674;916.3768637326615;938.938968967015;949.0888746803078;952.0431965874252;10613.5223914924;10634.840477392845;10703.892961070367;10731.892681073168;10763.515641796137;4143.937840932388;4185.560516145822;4226.239276930182;4238.724482908601;4241.257779888569;9204.355695101278;9244.121808428188;9262.95368523153;9275.58259878307;9286.442813431217;4611.677182597253;4629.745364004944;4635.490096089427;4639.118567472169;4646.535346465326;4179.247735407595;4206.621404073648;4217.40956266123;4217.746935183899;4219.493660760667;3418.6410426904818;3458.6368431314854;3652.214773823641;3682.410814269704;3718.535183102112;1185.608749112808;1192.0212447337378;1211.5941159711595;1218.1594699657207;1222.5904322052213;865.359633870931;868.1665601023088;868.5700578213824;877.5568337989274;948.9952550237205;7026.191987921352;7085.787426377217;7086.645667716697;7096.609686467294;7099.183593886769;1056.5668076088766;1058.7088550648634;1068.7862427514528;1083.7724077943562;1103.1836441033738;5537.031019571559;5561.416051314634;5567.526760225345;5571;5616.6068375213345;8989.235914947303;9013.864792028126;9226.40028398152;9291.95354023239;9401.341906066646;9396.718098457057;9398.389104708172;9403.670871519464;9408.200302974186;9410.482423466776;6837.487188460886;6952.2352541220425;6956.686949087303;7269.7455589054125;7374.668139933716;7185.497015208885;7196.208417074013;7223.2415596361625;7227.891581626385;7235.674394652358;7969.800754981172;8151.307138893023;8172.5913704315735;8310.501369917823;8320.750377488685;8338.541380224146;8413.705520307005;8587.355948303777;8599.613017414356;8610.311175105851;6828.419584335188;6930.930690693231;7045.612491313027;7065.470089743187;7076.25699301566;6463.224413070461;6537.084808126961;6906.412954898688;6911.723531058701;6939.271376505596;6442.226932768098;6660.234073081658;6669.2997235289595;6681.899771503334;6843.520953533404;6310.053491976057;6397.616143031433;6441.838954026187;6514.6416947068365;6554.573952693059;6492.156019717407;6492.610443373413;6520.543561950618;6521.902171467526;6535.019747037983;6187.474064704551;6192.287886892885;6195.101710252078;6262.624242545462;6271.749130034747;6191.288001879841;6300.71646775887;6322;6323.7786677466065;6328.746850125944 19:55:48 INFO - PROCESS | 5538 | |4;prototype.html;336.6936088159774;341.40084152312687;343.1010751830205;349.2003312414571;349.7604141163303;5869.911951320728;5909.970450147754;5950.137230101638;5954.285485741706;5974.761009559623;5593.8601534961645;5659.122835960433;5723.742431590578;5810.24466819314;5835.766569337221;4530.61489773368;4537.954620453786;4544.977275113636;4552.066826300609;4563.840265590705;4353.782310884443;4545.2954792007295;4549.499555048942;4557.02024064826;4559.749213793257;4375.934360984587;4389.4513185851765;4453.84411545596;4466.0844526871915;4467.687261891669;4416.514183439819;4417.4919884213405;4420.911581768379;4438.866833994969;4440.467143942716;3927.842886284574;3936.960630393688;3942.4086387041884;3947.3092208863336;3954.6638535724496;5485.314335708036;5571.13647384656;5584.832455026315;5587.329520457572;5591.0495215813;5225.137852254374;5237.633365664405;5239.449857764956;5240.842774716764;5249.370075590915;6175.845603859894;6183.598066125687;6187.81436556904;6188.947878860605;6194.5354098442795;4364.432623758891;4388.363687265329;4393.055493069006;4394.6923715339935;4406.449193850769;6343.080253363237;6449;6468.094466774608;6482.773102941422;6490.0589414534625;4494.16857881293;4497.370368148462;4502.099580083996;4502.257127573914;4505.774711264424;4585.037142200109;4587.288970209623;4587.610053145453;4588.977055114703;4589.862304130881;5234.26720259164;5243.659162154448;5246.658967167198;5253.921191182136;5254.211868219798;6104.572679912452;6259.311475737665;6267.467265282502;6268.717907694165;6268.968655156695;1619.0609446521225;1640.2536845735162;1641.0809946430038;1641.630633107565;1641.8850680452254;1097.4238524774398;1109.384291718088;1116.3748300951493;1121.0695123047851;1141.8915203055863;5885.382034886361;5913.58604897653;5917.940820591825;5920.141579470953;5924.081767326072;6440.581362211441;6440.8389790255615;6441.066045423388;6442.389402649338;6445.581037232565;5755.6834374108985;5846.619969701956;5892.292924849045;5895.027320492157;5901.439363260483;3481.7388695847912;3519;3524.8061356625117;3526.453399723047;3527.770694904823;6769.05233267343;6773.627450490172;6780.542183430487;6782.796516104525;6784.694688739019;6512.381323774234;6636;6653.4677225821815;6654;6655;6742.0224067509935;6746.123004009447;6748.055272261888;6751.426128779109;6759.459243260528;6478.902816457851;6488.870222595616;6499.740010399721;6506;6507.609543427409;6267.561270711007;6422.967885160544;6433.5496515243485;6438.774642887476;6442.742290308335;6719.630420326929;6730.764423245163;6763.695633696397;6764.966175169093;6767.35710107539;4533.297338912474;4533.727976321431;4537.251353526631;4539.182947069559;4543.727376357429;6357.777477788255;6487.935120648922;6510.056041873996;6512.674366281762;6515.087887695631;6335;6341.936580634319;6345.333739957238;6346.143270658402;6349.174607301022;6295.055741638791;6304.432601065742;6308.243010838729;6344.080108384166;6345.302016778059;6054.878902422015;6180.536459765445;6213.937860621336;6221.875562488634;6225.6926045530945;6356.0465930109;6361.045843123568;6361.395667411589;6366.4588509977175;6371.74513019474;6179.073139029181;6213.2233470816145;6226.12834203221;6227.4395304421005;6228.439440450381 19:55:48 INFO - PROCESS | 5538 | |5;yui.html;563.3633993587246;639.2871947778228;649.5258461323234;678.1049015299805;685.2633419074494;12783.169094008883;12999.740005199903;13008.284544350068;13011;13018.088733788638;11192.272502287366;11254.155938304619;11606.187566870301;11674;12116.939415302912;787.1577412168967;793.309820456204;800.3197282310048;800.5076877720219;803.2048272210528;788.8185717285028;799.077065988781;799.4363973398769;800.9399295052865;801.7033697531922;827.3711978896052;842.1788755962917;842.5155535567043;844.0462277626305;848.6350869126273;837.8826964225013;840.8108175660458;845.1252953193446;845.9407841451101;846.4582667093065;614.7878981751288;619.2228752915063;621;621.2824188062795;622.3745136138152;11564.94217528907;11702.473388697528;11724.58963936258;11761.529538818437;11776.352300623463;8850.336224783103;9029.503377314246;11057.225994180411;11119.110471162368;11239.66281011571;8524.57377131141;8839.29285657146;9224.492652904088;9261.120193581599;9460.763480912963;3382.9323413531592;3457.6888080072663;3469.5663042119736;3499.142710036032;3499.597546282185;45327.77336113298;46631.06737865224;46789;47928.76035619834;47997;8638.784030399165;8816.426932249384;8902.599383027778;8964;9038.954805225932;16214.189290535425;16216.59458513523;16226.837731622769;16230;16247.837521624633;7033.753818616324;7242.96378518104;7447.143578488543;7460.850782984418;7516.24837516255;4177.4569305990635;4189.874303770892;4197.202531519001;4204;4226.281532139482;2961.703829617064;3004.4141392428705;3006.2033561106323;3009.232645675339;3009.623797025372;503.42860852931454;521.7000224870715;527.1854984049653;539.5575627985093;556.5408537956203;456.79900843628695;457.90384019355645;461.9099275641285;476.6639519138999;489.1415565682276;7234.529755565872;7388.963055184797;7397.746295879891;7647.655855486517;7664.65509052094;450.794888325811;498.81045202822696;525.2777431032331;536.409949056043;540.2517513244185;3569.3575156471566;3601.549806274216;3626.111602657366;3732.309522738302;3984.183242435294;49616.50383496191;49979;50246.24630630543;52813.47186528162;53676.463235367926;42843.35734963978;44005.33991990123;48110.51889481131;48165;48233;42890.571094289284;44020.77989610031;44411.777941110086;44570.77714611406;45161.32258016132;7737.497062690907;8249.587520624065;8394;8530.658773648984;8559.443636163878;33603.49594756032;34162.65837341595;34524;34772.478412824334;35265.29469410546;42516;43275.567244327154;43323;44303.556964431235;44868.10263794771;9345.532723363669;9625.614975401186;10159.542820572944;10601.628942986958;10776.838347424638;11031.172662050218;11149.163812713916;11151.944240278746;11154.107671386108;11163;9473.621055157717;9618;9654.662086826927;9713.854292185764;9806.411615303105;10104.343217690826;10200.897991019994;10391.168706503613;10397.272190946562;10434.37393756377;10348.228964280437;10572.735681607714;10592.788144237225;10661;10793.188360559094;8785.736427906917;8880.777980550538;8965.193132617835;9397.154256116983;9462;9119.190648110845;9267.258619310303;9272.536373181449;9285.303602229995;9354.158125768714 19:55:48 INFO - PROCESS | 5538 | __end_tp_report 19:55:48 INFO - PROCESS | 5538 | __start_cc_report 19:55:48 INFO - PROCESS | 5538 | _x_x_mozilla_cycle_collect,1021 19:55:48 INFO - PROCESS | 5538 | __end_cc_report 19:55:48 INFO - PROCESS | 5538 | __startTimestamp1451966148362__endTimestamp 19:55:48 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | ------- Summary: start ------- 19:55:48 INFO - PROCESS | 5538 | Number of tests: 6 19:55:48 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | [#0] dojo.html Cycles:165 Average:5188.92 Median:5364.20 stddev:558.98 (10.4%) stddev-sans-first:537.03 19:55:48 INFO - PROCESS | 5538 | Values: 3137.6 3165.9 3218.4 3227.0 3251.5 5074.8 5184.8 5193.0 5204.0 5248.3 5189.6 5232.9 5239.4 5240.2 5335.0 4664.1 4721.4 4737.7 4760.2 4815.8 4780.8 4807.1 4818.3 4856.2 4878.4 4655.9 4675.5 4739.9 4757.2 4789.8 4709.1 4728.4 4744.5 4757.8 4783.3 4722.8 4744.2 4754.6 4765.2 4789.0 4909.8 4951.1 5001.1 5073.3 5085.3 5592.9 5597.2 5601.6 5601.7 5603.7 5525.5 5612.7 5628.3 5629.7 5633.6 5203.5 5227.3 5253.2 5281.4 5306.1 5762.8 5779.8 5780.1 5784.0 5834.4 5424.4 5565.8 5568.7 5571.1 5571.4 5488.6 5492.3 5513.3 5557.7 5610.7 5585.6 5630.1 5636.1 5638.9 5640.2 5426.1 5573.6 5654.9 5656.8 5660.5 4327.4 4372.1 4435.9 4439.7 4476.8 3891.2 3895.8 3903.5 3935.2 3937.4 5078.1 5172.1 5182.3 5194.4 5243.2 5600.7 5631.7 5666.2 5667.0 5703.5 5173.0 5200.7 5204.5 5206.1 5253.7 4637.4 4654.1 4739.6 4789.1 4796.1 5719.9 5768.4 5792.2 5801.9 5828.8 5595.4 5616.0 5620.9 5622.2 5627.7 5653.3 5739.6 5754.3 5755.2 5818.3 5442.8 5449.8 5461.0 5484.3 5493.7 5472.9 5515.6 5515.8 5529.6 5549.1 5362.4 5406.8 5412.0 5460.3 5471.2 5399.5 5448.0 5504.2 5517.8 5549.1 5348.7 5349.8 5357.4 5359.2 5364.2 5367.9 5400.9 5436.2 5441.5 5502.4 5311.9 5350.5 5374.9 5383.4 5426.9 19:55:48 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | [#1] ext.html Cycles:180 Average:43313.06 Median:31455.26 stddev:70800.47 (225.1%) stddev-sans-first:70926.20 19:55:48 INFO - PROCESS | 5538 | Values: 527.9 552.5 562.1 565.7 571.1 28883.4 29505.6 29597.0 37198.8 37687.4 41030.8 41302.4 41538.4 41608.2 41659.0 8274.2 8458.4 8458.7 8489.0 8531.3 7507.3 7650.1 7654.7 10159.7 10392.8 10070.8 10172.1 10174.6 10178.6 10178.9 10074.3 10160.6 10174.4 10181.3 10197.1 7246.1 7366.7 7368.4 10093.2 10348.4 36506.5 37267.4 37276.4 37297.6 37342.8 3003.8 3051.8 3124.4 3125.2 3329.8 30140.7 30885.2 31789.3 32844.0 33312.0 3633.8 3651.2 3661.8 3867.2 3944.4 273198.0 276957.0 277831.0 278378.0 278402.0 53326.0 60207.7 60562.0 60625.0 60683.1 47948.0 64474.0 65450.7 65680.7 65701.7 13027.9 13050.9 13057.2 13060.8 13091.5 9580.8 9595.0 9607.4 9637.0 9646.6 19274.7 19329.0 19352.3 19387.8 19970.9 7386.5 7761.6 7781.2 7909.8 7926.6 943.6 948.4 1042.1 1048.2 1069.8 27888.3 28337.7 28647.1 28849.0 28893.3 1039.6 1074.8 1088.0 1093.3 1102.0 14628.6 14658.9 14863.4 15098.1 15115.8 303117.0 304974.0 305241.0 307892.0 309303.0 51694.2 52267.7 52316.5 52455.5 52542.2 1299.3 1308.1 1309.1 1311.0 1318.3 25752.6 26794.5 28383.7 28636.4 29323.3 41353.0 42001.8 42041.4 42071.4 42092.0 220764.0 223109.0 223332.0 223437.0 224180.0 26611.1 27958.9 28210.9 31611.5 32064.5 36572.8 36577.8 37056.0 37329.8 37571.2 31715.8 31724.7 31808.7 32113.5 32223.5 29022.6 33335.8 33500.0 33858.3 34193.3 31299.0 31744.7 32025.4 32085.5 32535.0 29155.6 29946.6 30752.2 30781.8 30898.8 23715.0 23854.2 24301.5 24350.0 24526.8 19:55:48 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | [#2] jquery.html Cycles:180 Average:28551.37 Median:19930.95 stddev:88573.06 (444.4%) stddev-sans-first:88796.23 19:55:48 INFO - PROCESS | 5538 | Values: 354.3 355.2 355.8 357.5 358.1 14012.6 14354.4 16160.4 16352.9 17010.2 15684.8 16545.0 16725.6 17068.4 17086.8 5194.4 5325.2 5327.1 5330.2 5333.5 3859.1 3996.4 5351.5 5378.4 5583.2 5673.1 5728.8 5758.3 5771.5 5783.2 5569.5 5715.9 5734.0 5775.3 5787.9 5102.4 5105.3 5115.0 5116.6 5119.7 18974.9 20229.0 20361.6 20425.8 20427.6 2002.9 2046.2 2060.1 2070.6 2165.8 12780.6 13154.8 13160.1 13288.5 13536.7 1774.8 1816.3 1848.9 1879.8 1899.7 58291.7 60324.7 60325.0 61304.4 62085.4 9541.9 9672.7 9832.9 9845.6 9910.5 12220.5 12269.6 12290.8 12296.4 12299.6 7121.5 7161.3 7169.9 7223.7 7334.2 6917.4 6939.6 6971.0 6998.9 7026.3 4033.3 4188.7 4254.8 4279.7 4335.5 1708.2 1754.9 1759.3 1779.6 1843.4 442.1 443.1 462.7 948.4 982.9 10459.7 10809.4 16208.9 16846.2 17592.9 807.7 943.6 950.8 992.5 1016.7 9002.8 9030.9 9124.0 9245.2 9472.0 525497.0 533137.0 536261.0 537911.0 578128.0 67800.7 68669.3 69604.7 77638.0 81700.6 1105.8 1130.3 1134.2 1134.8 1148.9 15157.7 15223.4 15398.8 15408.0 15764.9 34131.3 34580.5 35206.5 35399.8 36002.8 46017.0 46949.5 47452.5 48560.0 51018.7 9098.5 9366.3 9419.0 9439.3 9441.9 11238.9 16089.4 16859.2 17247.1 17340.6 14207.4 14214.7 14332.9 14605.3 14678.3 13869.7 14000.9 14072.0 14110.4 14616.3 11399.6 11586.4 12551.4 12584.2 14666.2 8740.7 8763.4 8808.7 8883.1 9307.2 13292.8 13352.3 13472.9 13571.7 14428.3 19:55:48 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | [#3] mootools.html Cycles:180 Average:5318.30 Median:6363.18 stddev:2794.39 (43.9%) stddev-sans-first:2785.75 19:55:48 INFO - PROCESS | 5538 | Values: 1281.1 1437.8 1441.1 1574.0 1786.7 6873.1 7481.1 7583.5 7587.2 7598.2 7408.2 7645.4 7651.9 7665.2 7676.2 1917.1 1950.4 2191.0 2254.2 2290.9 2237.5 2244.6 2247.8 2248.1 2250.0 2121.7 2192.1 2197.9 2199.9 2202.7 2195.2 2209.3 2229.7 2264.7 2266.6 2234.6 2242.3 2269.7 2273.2 2332.1 7581.0 7593.9 7616.7 7704.8 7716.2 4380.5 4476.1 4492.6 4496.5 4496.8 2891.9 2961.5 3010.0 3025.9 3027.7 911.1 916.4 938.9 949.1 952.0 10613.5 10634.8 10703.9 10731.9 10763.5 4143.9 4185.6 4226.2 4238.7 4241.3 9204.4 9244.1 9263.0 9275.6 9286.4 4611.7 4629.7 4635.5 4639.1 4646.5 4179.2 4206.6 4217.4 4217.7 4219.5 3418.6 3458.6 3652.2 3682.4 3718.5 1185.6 1192.0 1211.6 1218.2 1222.6 865.4 868.2 868.6 877.6 949.0 7026.2 7085.8 7086.6 7096.6 7099.2 1056.6 1058.7 1068.8 1083.8 1103.2 5537.0 5561.4 5567.5 5571.0 5616.6 8989.2 9013.9 9226.4 9292.0 9401.3 9396.7 9398.4 9403.7 9408.2 9410.5 6837.5 6952.2 6956.7 7269.7 7374.7 7185.5 7196.2 7223.2 7227.9 7235.7 7969.8 8151.3 8172.6 8310.5 8320.8 8338.5 8413.7 8587.4 8599.6 8610.3 6828.4 6930.9 7045.6 7065.5 7076.3 6463.2 6537.1 6906.4 6911.7 6939.3 6442.2 6660.2 6669.3 6681.9 6843.5 6310.1 6397.6 6441.8 6514.6 6554.6 6492.2 6492.6 6520.5 6521.9 6535.0 6187.5 6192.3 6195.1 6262.6 6271.7 6191.3 6300.7 6322.0 6323.8 6328.7 19:55:48 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | [#4] prototype.html Cycles:180 Average:5249.03 Median:5898.23 stddev:1571.14 (26.6%) stddev-sans-first:1531.67 19:55:48 INFO - PROCESS | 5538 | Values: 336.7 341.4 343.1 349.2 349.8 5869.9 5910.0 5950.1 5954.3 5974.8 5593.9 5659.1 5723.7 5810.2 5835.8 4530.6 4538.0 4545.0 4552.1 4563.8 4353.8 4545.3 4549.5 4557.0 4559.7 4375.9 4389.5 4453.8 4466.1 4467.7 4416.5 4417.5 4420.9 4438.9 4440.5 3927.8 3937.0 3942.4 3947.3 3954.7 5485.3 5571.1 5584.8 5587.3 5591.0 5225.1 5237.6 5239.4 5240.8 5249.4 6175.8 6183.6 6187.8 6188.9 6194.5 4364.4 4388.4 4393.1 4394.7 4406.4 6343.1 6449.0 6468.1 6482.8 6490.1 4494.2 4497.4 4502.1 4502.3 4505.8 4585.0 4587.3 4587.6 4589.0 4589.9 5234.3 5243.7 5246.7 5253.9 5254.2 6104.6 6259.3 6267.5 6268.7 6269.0 1619.1 1640.3 1641.1 1641.6 1641.9 1097.4 1109.4 1116.4 1121.1 1141.9 5885.4 5913.6 5917.9 5920.1 5924.1 6440.6 6440.8 6441.1 6442.4 6445.6 5755.7 5846.6 5892.3 5895.0 5901.4 3481.7 3519.0 3524.8 3526.5 3527.8 6769.1 6773.6 6780.5 6782.8 6784.7 6512.4 6636.0 6653.5 6654.0 6655.0 6742.0 6746.1 6748.1 6751.4 6759.5 6478.9 6488.9 6499.7 6506.0 6507.6 6267.6 6423.0 6433.5 6438.8 6442.7 6719.6 6730.8 6763.7 6765.0 6767.4 4533.3 4533.7 4537.3 4539.2 4543.7 6357.8 6487.9 6510.1 6512.7 6515.1 6335.0 6341.9 6345.3 6346.1 6349.2 6295.1 6304.4 6308.2 6344.1 6345.3 6054.9 6180.5 6213.9 6221.9 6225.7 6356.0 6361.0 6361.4 6366.5 6371.7 6179.1 6213.2 6226.1 6227.4 6228.4 19:55:48 INFO - PROCESS | 5538 | 19:55:48 INFO - PROCESS | 5538 | [#5] yui.html Cycles:180 Average:12808.91 Median:24361.07 stddev:14982.64 (61.5%) stddev-sans-first:14996.44 19:55:48 INFO - PROCESS | 5538 | Values: 563.4 639.3 649.5 678.1 685.3 12783.2 12999.7 13008.3 13011.0 13018.1 11192.3 11254.2 11606.2 11674.0 12116.9 787.2 793.3 800.3 800.5 803.2 788.8 799.1 799.4 800.9 801.7 827.4 842.2 842.5 844.0 848.6 837.9 840.8 845.1 845.9 846.5 614.8 619.2 621.0 621.3 622.4 11564.9 11702.5 11724.6 11761.5 11776.4 8850.3 9029.5 11057.2 11119.1 11239.7 8524.6 8839.3 9224.5 9261.1 9460.8 3382.9 3457.7 3469.6 3499.1 3499.6 45327.8 46631.1 46789.0 47928.8 47997.0 8638.8 8816.4 8902.6 8964.0 9039.0 16214.2 16216.6 16226.8 16230.0 16247.8 7033.8 7243.0 7447.1 7460.9 7516.2 4177.5 4189.9 4197.2 4204.0 4226.3 2961.7 3004.4 3006.2 3009.2 3009.6 503.4 521.7 527.2 539.6 556.5 456.8 457.9 461.9 476.7 489.1 7234.5 7389.0 7397.7 7647.7 7664.7 450.8 498.8 525.3 536.4 540.3 3569.4 3601.5 3626.1 3732.3 3984.2 49616.5 49979.0 50246.2 52813.5 53676.5 42843.4 44005.3 48110.5 48165.0 48233.0 42890.6 44020.8 44411.8 44570.8 45161.3 7737.5 8249.6 8394.0 8530.7 8559.4 33603.5 34162.7 34524.0 34772.5 35265.3 42516.0 43275.6 43323.0 44303.6 44868.1 9345.5 9625.6 10159.5 10601.6 10776.8 11031.2 11149.2 11151.9 11154.1 11163.0 9473.6 9618.0 9654.7 9713.9 9806.4 10104.3 10200.9 10391.2 10397.3 10434.4 10348.2 10572.7 10592.8 10661.0 10793.2 8785.7 8880.8 8965.2 9397.2 9462.0 9119.2 9267.3 9272.5 9285.3 9354.2 19:55:48 INFO - PROCESS | 5538 | -------- Summary: end -------- 19:55:48 INFO - PROCESS | 5538 | 19:55:49 INFO - TEST-INFO | 5538: exit 0 19:55:49 INFO - TEST-OK | dromaeo_css | took 1112234ms 19:55:49 INFO - TEST-START | kraken 19:55:49 INFO - operating with platform_type : linux_ 19:55:49 INFO - Initialising browser for kraken test... 19:55:49 INFO - TEST-INFO | started process 5726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPEV0F0/profile http://localhost:48033/getInfo.html) 19:55:53 INFO - PROCESS | 5726 | __metrics Screen width/height:1600/1200 19:55:53 INFO - PROCESS | 5726 | colorDepth:24 19:55:53 INFO - PROCESS | 5726 | Browser inner width/height: 1024/697 19:55:53 INFO - PROCESS | 5726 | __metrics 19:55:53 INFO - PROCESS | 5726 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:55:53 INFO - PROCESS | 5726 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:55:53 INFO - TEST-INFO | 5726: exit 0 19:55:53 INFO - Browser initialized. 19:55:53 INFO - Running cycle 1/1 for kraken test... 19:55:53 INFO - TEST-INFO | started process 5809 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPEV0F0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:05 INFO - PROCESS | 5809 | RSS: Main: 150245376 19:56:05 INFO - PROCESS | 5809 | 19:56:08 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48033/tests/kraken/driver.html?testName=audio-beat-detection) 19:56:08 INFO - PROCESS | 5809 | RSS: Main: 186236928 19:56:08 INFO - PROCESS | 5809 | 19:56:11 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48033/tests/kraken/driver.html?testName=audio-dft) 19:56:11 INFO - PROCESS | 5809 | RSS: Main: 174489600 19:56:11 INFO - PROCESS | 5809 | 19:56:14 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48033/tests/kraken/driver.html?testName=audio-fft) 19:56:15 INFO - PROCESS | 5809 | RSS: Main: 161538048 19:56:15 INFO - PROCESS | 5809 | 19:56:17 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48033/tests/kraken/driver.html?testName=audio-oscillator) 19:56:18 INFO - PROCESS | 5809 | RSS: Main: 163397632 19:56:18 INFO - PROCESS | 5809 | 19:56:20 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:20 INFO - PROCESS | 5809 | RSS: Main: 164691968 19:56:20 INFO - PROCESS | 5809 | 19:56:23 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48033/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:24 INFO - PROCESS | 5809 | RSS: Main: 165376000 19:56:24 INFO - PROCESS | 5809 | 19:56:27 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48033/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:28 INFO - PROCESS | 5809 | RSS: Main: 166555648 19:56:28 INFO - PROCESS | 5809 | 19:56:30 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48033/tests/kraken/driver.html?testName=json-parse-financial) 19:56:31 INFO - PROCESS | 5809 | RSS: Main: 166105088 19:56:31 INFO - PROCESS | 5809 | 19:56:33 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:33 INFO - PROCESS | 5809 | RSS: Main: 173248512 19:56:33 INFO - PROCESS | 5809 | 19:56:35 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:36 INFO - PROCESS | 5809 | RSS: Main: 172720128 19:56:36 INFO - PROCESS | 5809 | 19:56:38 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:38 INFO - PROCESS | 5809 | RSS: Main: 179556352 19:56:38 INFO - PROCESS | 5809 | 19:56:41 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:41 INFO - PROCESS | 5809 | RSS: Main: 191635456 19:56:41 INFO - PROCESS | 5809 | 19:56:44 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:44 INFO - PROCESS | 5809 | RSS: Main: 190345216 19:56:44 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:48033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48033/tests/kraken/driver.html?testName=ai-astar) 19:56:46 INFO - PROCESS | 5809 | RSS: Main: 247537664 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | __start_tp_report 19:56:46 INFO - PROCESS | 5809 | _x_x_mozilla_page_load 19:56:46 INFO - PROCESS | 5809 | _x_x_mozilla_page_load_details 19:56:46 INFO - PROCESS | 5809 | |i|pagename|runs| 19:56:46 INFO - PROCESS | 5809 | |0;ai-astar;110;111;106;111;111;111;100;109;109;112 19:56:46 INFO - PROCESS | 5809 | |1;audio-beat-detection;146;124;150;162;130;153;156;126;178;128 19:56:46 INFO - PROCESS | 5809 | |2;audio-dft;161;159;160;160;159;162;162;162;162;161 19:56:46 INFO - PROCESS | 5809 | |3;audio-fft;71;71;87;97;70;73;72;119;93;71 19:56:46 INFO - PROCESS | 5809 | |4;audio-oscillator;105;97;139;96;98;97;140;97;97;134 19:56:46 INFO - PROCESS | 5809 | |5;imaging-gaussian-blur;110;109;110;110;109;109;110;109;109;109 19:56:46 INFO - PROCESS | 5809 | |6;imaging-darkroom;145;144;145;145;145;145;145;145;145;146 19:56:46 INFO - PROCESS | 5809 | |7;imaging-desaturate;96;95;96;95;96;96;96;95;95;96 19:56:46 INFO - PROCESS | 5809 | |8;json-parse-financial;57;58;57;57;57;56;55;64;55;55 19:56:46 INFO - PROCESS | 5809 | |9;json-stringify-tinderbox;67;67;67;67;68;68;68;67;68;68 19:56:46 INFO - PROCESS | 5809 | |10;stanford-crypto-aes;86;88;86;86;86;92;85;85;87;85 19:56:46 INFO - PROCESS | 5809 | |11;stanford-crypto-ccm;122;122;122;116;116;115;118;125;125;118 19:56:46 INFO - PROCESS | 5809 | |12;stanford-crypto-pbkdf2;151;142;149;148;150;148;149;141;149;140 19:56:46 INFO - PROCESS | 5809 | |13;stanford-crypto-sha256-iterative;68;69;69;68;68;70;69;73;71;68 19:56:46 INFO - PROCESS | 5809 | __end_tp_report 19:56:46 INFO - PROCESS | 5809 | __start_cc_report 19:56:46 INFO - PROCESS | 5809 | _x_x_mozilla_cycle_collect,918 19:56:46 INFO - PROCESS | 5809 | __end_cc_report 19:56:46 INFO - PROCESS | 5809 | __startTimestamp1451966206743__endTimestamp 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | ------- Summary: start ------- 19:56:46 INFO - PROCESS | 5809 | Number of tests: 14 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.59 (3.2%) stddev-sans-first:3.79 19:56:46 INFO - PROCESS | 5809 | Values: 110.0 111.0 106.0 111.0 111.0 111.0 100.0 109.0 109.0 112.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:151.50 stddev:17.96 (11.9%) stddev-sans-first:19.05 19:56:46 INFO - PROCESS | 5809 | Values: 146.0 124.0 150.0 162.0 130.0 153.0 156.0 126.0 178.0 128.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.50 stddev:1.23 (0.8%) stddev-sans-first:1.30 19:56:46 INFO - PROCESS | 5809 | Values: 161.0 159.0 160.0 160.0 159.0 162.0 162.0 162.0 162.0 161.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#3] audio-fft Cycles:10 Average:82.40 Median:72.50 stddev:16.42 (22.6%) stddev-sans-first:16.89 19:56:46 INFO - PROCESS | 5809 | Values: 71.0 71.0 87.0 97.0 70.0 73.0 72.0 119.0 93.0 71.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:97.00 stddev:19.32 (19.9%) stddev-sans-first:20.40 19:56:46 INFO - PROCESS | 5809 | Values: 105.0 97.0 139.0 96.0 98.0 97.0 140.0 97.0 97.0 134.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:56:46 INFO - PROCESS | 5809 | Values: 110.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 19:56:46 INFO - PROCESS | 5809 | Values: 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:56:46 INFO - PROCESS | 5809 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:2.64 (4.6%) stddev-sans-first:2.80 19:56:46 INFO - PROCESS | 5809 | Values: 57.0 58.0 57.0 57.0 57.0 56.0 55.0 64.0 55.0 55.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:56:46 INFO - PROCESS | 5809 | Values: 67.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.00 stddev:2.12 (2.5%) stddev-sans-first:2.24 19:56:46 INFO - PROCESS | 5809 | Values: 86.0 88.0 86.0 86.0 86.0 92.0 85.0 85.0 87.0 85.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:122.00 stddev:3.75 (3.1%) stddev-sans-first:3.91 19:56:46 INFO - PROCESS | 5809 | Values: 122.0 122.0 122.0 116.0 116.0 115.0 118.0 125.0 125.0 118.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:149.00 stddev:4.06 (2.7%) stddev-sans-first:3.99 19:56:46 INFO - PROCESS | 5809 | Values: 151.0 142.0 149.0 148.0 150.0 148.0 149.0 141.0 149.0 140.0 19:56:46 INFO - PROCESS | 5809 | 19:56:46 INFO - PROCESS | 5809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.64 (2.4%) stddev-sans-first:1.67 19:56:46 INFO - PROCESS | 5809 | Values: 68.0 69.0 69.0 68.0 68.0 70.0 69.0 73.0 71.0 68.0 19:56:46 INFO - PROCESS | 5809 | -------- Summary: end -------- 19:56:46 INFO - PROCESS | 5809 | 19:56:47 INFO - TEST-INFO | 5809: exit 0 19:56:47 INFO - TEST-OK | kraken | took 58509ms 19:56:47 INFO - TEST-START | v8_7 19:56:47 INFO - operating with platform_type : linux_ 19:56:47 INFO - Initialising browser for v8_7 test... 19:56:47 INFO - TEST-INFO | started process 6057 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzMicMd/profile http://localhost:48033/getInfo.html) 19:56:51 INFO - PROCESS | 6057 | __metrics Screen width/height:1600/1200 19:56:51 INFO - PROCESS | 6057 | colorDepth:24 19:56:51 INFO - PROCESS | 6057 | Browser inner width/height: 1024/697 19:56:51 INFO - PROCESS | 6057 | __metrics 19:56:51 INFO - PROCESS | 6057 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:56:51 INFO - PROCESS | 6057 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:56:52 INFO - TEST-INFO | 6057: exit 0 19:56:52 INFO - Browser initialized. 19:56:52 INFO - Running cycle 1/1 for v8_7 test... 19:56:52 INFO - TEST-INFO | started process 6140 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzMicMd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:04 INFO - PROCESS | 6140 | RSS: Main: 149860352 19:57:04 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | Cycle 1(1): loaded http://localhost:48033/tests/v8_7/run.html (next: http://localhost:48033/tests/v8_7/run.html) 19:57:25 INFO - PROCESS | 6140 | RSS: Main: 551149568 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | __start_tp_report 19:57:25 INFO - PROCESS | 6140 | _x_x_mozilla_page_load 19:57:25 INFO - PROCESS | 6140 | _x_x_mozilla_page_load_details 19:57:25 INFO - PROCESS | 6140 | |i|pagename|runs| 19:57:25 INFO - PROCESS | 6140 | |0;Richards;166.5278934221482 19:57:25 INFO - PROCESS | 6140 | |1;DeltaBlue;194.06171162429652 19:57:25 INFO - PROCESS | 6140 | |2;Encrypt;283.7684449489217 19:57:25 INFO - PROCESS | 6140 | |3;Decrypt;5240.837696335078 19:57:25 INFO - PROCESS | 6140 | |4;RayTrace;1980.1980198019803 19:57:25 INFO - PROCESS | 6140 | |5;Earley;791.1392405063291 19:57:25 INFO - PROCESS | 6140 | |6;Boyer;12500 19:57:25 INFO - PROCESS | 6140 | |7;RegExp;26000 19:57:25 INFO - PROCESS | 6140 | |8;Splay;578.7037037037037 19:57:25 INFO - PROCESS | 6140 | |9;NavierStokes;4830.917874396136 19:57:25 INFO - PROCESS | 6140 | __end_tp_report 19:57:25 INFO - PROCESS | 6140 | __startTimestamp1451966245967__endTimestamp 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | ------- Summary: start ------- 19:57:25 INFO - PROCESS | 6140 | Number of tests: 10 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 166.5 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#1] DeltaBlue Cycles:1 Average:194.06 Median:194.06 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 194.1 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#2] Encrypt Cycles:1 Average:283.77 Median:283.77 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 283.8 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 5240.8 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 1980.2 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 791.1 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 12500.0 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 26000.0 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#8] Splay Cycles:1 Average:578.70 Median:578.70 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 578.7 19:57:25 INFO - PROCESS | 6140 | 19:57:25 INFO - PROCESS | 6140 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:57:25 INFO - PROCESS | 6140 | Values: 4830.9 19:57:25 INFO - PROCESS | 6140 | -------- Summary: end -------- 19:57:25 INFO - PROCESS | 6140 | 19:57:26 INFO - TEST-INFO | 6140: exit 0 19:57:26 INFO - TEST-OK | v8_7 | took 39214ms 19:57:26 INFO - SUITE-END | took 1209s 19:57:27 INFO - Completed test suite (00:20:10) 19:57:27 INFO - Working with test: dromaeo_css 19:57:27 INFO - Generating results file: dromaeo_css 19:57:27 INFO - Working with test: kraken 19:57:27 INFO - Generating results file: kraken 19:57:27 INFO - javascript benchmark 19:57:27 INFO - Working with test: v8_7 19:57:27 INFO - Generating results file: v8_7 19:57:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:57:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 19:57:27 INFO - process_Request line: dromaeo_css 6741.84 graph.html#tests=[[72,64,35]] 19:57:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:57:27 INFO - process_Request line: kraken 1504.60 graph.html#tests=[[232,64,35]] 19:57:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:57:27 INFO - process_Request line: v8_7 19764.98 graph.html#tests=[[230,64,35]] 19:57:27 INFO - RETURN: dromaeo_css: 6741.84 19:57:27 INFO - RETURN: kraken: 1504.60 19:57:27 INFO - RETURN: v8_7: 19764.98 19:57:27 INFO - javascript benchmark 19:57:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.5921130253073, 3165.8733650653976, 3218.4206842768294, 3227.0, 3251.512273159026, 5074.822381216658, 5184.792608295664, 5193.039287731773, 5203.95920815837, 5248.291480650107, 5189.558887494568, 5232.8691782705455, 5239.423663397033, 5240.240165176047, 5335.039692855285, 4664.090502352043, 4721.362616046824, 4737.668363214576, 4760.214564596838, 4815.783289751952, 4780.760961951906, 4807.086653535835, 4818.277258411232, 4856.247281671329, 4878.365812444377, 4655.860324190246, 4675.462321832982, 4739.881502962454, 4757.215059515176, 4789.832355867528, 4709.081729062834, 4728.40894888139, 4744.5492678195515, 4757.809687612491, 4783.3064205690325, 4722.83470078549, 4744.240921452551, 4754.619630429557, 4765.189917713997, 4788.9521104788855, 4909.7790599423115, 4951.108800415924, 5001.149804533202, 5073.340465739467, 5085.288059671649, 5592.86017849553, 5597.216389705403, 5601.60788744788, 5601.747921343549, 5603.719814009283, 5525.475079867406, 5612.69130197839, 5628.296462942132, 5629.662220266797, 5633.63381380209, 5203.531682148625, 5227.3465816772905, 5253.159494480903, 5281.445448227881, 5306.097963346202, 5762.769489220468, 5779.826605201851, 5780.132980053026, 5784.045632470679, 5834.358220595731, 5424.403315635277, 5565.833025009256, 5568.749406276727, 5571.1086226203615, 5571.442855714477, 5488.643238189505, 5492.286002819608, 5513.283273174462, 5557.749901254453, 5610.663360198319, 5585.609007369445, 5630.071038278638, 5636.126400407943, 5638.859028524238, 5640.210370548127, 5426.077566813651, 5573.637713548606, 5654.886902261932, 5656.8020119295625, 5660.518855897212, 4327.350897365421, 4372.147431250939, 4435.933460998088, 4439.667024973075, 4476.843310484118, 3891.2412079644196, 3895.844166233319, 3903.512060992376, 3935.173613541131, 3937.448757173998, 5078.060558796635, 5172.069027575073, 5182.300389447451, 5194.428612852583, 5243.213517972258, 5600.747966341524, 5631.6902570359025, 5666.206731057655, 5666.97166514173, 5703.458171473703, 5172.9741351293005, 5200.713960732196, 5204.453532379046, 5206.062908676475, 5253.711045892436, 4637.420322459692, 4654.092451971833, 4739.644526660514, 4789.114013907369, 4796.112719146969, 5719.857003574861, 5768.423157684198, 5792.21805056312, 5801.9129713054335, 5828.825135245949, 5595.384507704068, 5616.045272303636, 5620.887582248414, 5622.212890195294, 5627.7467513961155, 5653.349864765604, 5739.62692424991, 5754.280714910468, 5755.223044888887, 5818.272715910512, 5442.836714898559, 5449.754761035683, 5461.0, 5484.287042684426, 5493.6978466183145, 5472.91790623133, 5515.61390702647, 5515.834524964257, 5529.585281104014, 5549.112142057252, 5362.436944120811, 5406.756695948613, 5411.972940135274, 5460.31746031746, 5471.206675032177, 5399.541039011571, 5447.972760136174, 5504.22940788298, 5517.779288828402, 5549.139883317931, 5348.732563371894, 5349.839504814861, 5357.410684824588, 5359.196120581944, 5364.195370694427, 5367.919481207863, 5400.945990540202, 5436.238926550365, 5441.455854414527, 5502.394736579053, 5311.893762124813, 5350.491703288181, 5374.892502150014, 5383.353997520166, 5426.864328391822], "unit": "score", "name": "dojo.html", "value": 5154.196124789246}, {"lowerIsBetter": false, "replicates": [527.85747848081, 552.488947723356, 562.1287005142029, 565.6916980245766, 571.0805602979203, 28883.378659414473, 29505.557416638767, 29597.0, 37198.81400593, 37687.434688479625, 41030.794846025725, 41302.38046429306, 41538.376924346085, 41608.167836643326, 41659.0, 8274.213949674771, 8458.407911446202, 8458.66165353385, 8489.0, 8531.317494600447, 7507.324340809326, 7650.08199016116, 7654.693812247503, 10159.746006349826, 10392.792144157112, 10070.848937265946, 10172.13536849365, 10174.59301627934, 10178.643747468841, 10178.949105254464, 10074.294799364048, 10160.59357625694, 10174.422964440524, 10181.33821301613, 10197.082262596401, 7246.130464344313, 7366.668499917463, 7368.410527157815, 10093.192544596415, 10348.430836304, 36506.452403213974, 37267.44098838492, 37276.44085338722, 37297.627023729685, 37342.81328593367, 3003.8197708137363, 3051.7711171662213, 3124.4376012317775, 3125.2030732163153, 3329.8002119872885, 30140.698593014007, 30885.227869303224, 31789.26887674928, 32844.0, 33312.0, 3633.7819730815972, 3651.1602331463914, 3661.8169091545315, 3867.245887052026, 3944.3534378232303, 273198.0, 276957.0, 277831.0, 278378.0, 278402.0, 53326.0, 60207.69896150491, 60562.0, 60625.0, 60683.08975365373, 47948.0, 64474.0, 65450.67274663596, 65680.67159664171, 65701.67149164224, 13027.934860325639, 13050.869491305155, 13057.151285166434, 13060.804087938688, 13091.541796037283, 9580.808383832424, 9594.952025239829, 9607.423554586747, 9637.036296370306, 9646.565904534313, 19274.71087933682, 19329.0, 19352.32266870653, 19387.8061219386, 19970.90014549918, 7386.482946193715, 7761.573113478813, 7781.182975787574, 7909.802254943673, 7926.603669816486, 943.5659596585648, 948.3977674176809, 1042.1142029275056, 1048.1614708233383, 1069.8020866139789, 27888.302792430353, 28337.71662283392, 28647.14058578246, 28849.0, 28893.27766805847, 1039.5581877701945, 1074.7957888001254, 1088.0153461117702, 1093.327603523827, 1102.0081926266264, 14628.634284142981, 14658.853411465961, 14863.405463781544, 15098.094114353175, 15115.848841511444, 303117.0, 304974.0, 305241.0, 307892.0, 309303.0, 51694.22458663123, 52267.73866130721, 52316.47683523116, 52455.47544524506, 52542.21186682203, 1299.311364976564, 1308.084340961312, 1309.0509380698918, 1310.9541166059141, 1318.347418028063, 25752.61371079398, 26794.464110718065, 28383.716162838107, 28636.42727145487, 29323.266918327212, 41353.0, 42001.78999104985, 42041.369379459946, 42071.36892946547, 42092.0, 220764.0, 223109.0, 223332.0, 223437.0, 224180.0, 26611.068612598465, 27958.860205698842, 28210.85894570596, 31611.525827112153, 32064.51903221407, 36572.81713591415, 36577.81711091428, 37056.0, 37329.81335093307, 37571.24857502889, 31715.84142079275, 31724.682753173096, 31808.6819131815, 32113.518297226026, 32223.516647250777, 29022.564661530516, 33335.83332083324, 33500.039929723374, 33858.32283354369, 34193.31613367768, 31299.0, 31744.6825531751, 32025.35949281048, 32085.518717218794, 32535.0, 29155.562666559596, 29946.550801737554, 30752.231194220323, 30781.846090769403, 30898.845505772326, 23715.0, 23854.16510422127, 24301.51396972086, 24350.0, 24526.754732452446], "unit": "score", "name": "ext.html", "value": 17705.80662839676}, {"lowerIsBetter": false, "replicates": [354.3213307396084, 355.1618181092621, 355.8149762123694, 357.46915829992474, 358.1297447203296, 14012.579622611313, 14354.354054067591, 16160.353585856566, 16352.91823540882, 17010.234539445722, 15684.764728529053, 16545.0, 16725.581860453465, 17068.402605908796, 17086.82913170868, 5194.428612852583, 5325.174597937306, 5327.121025030865, 5330.200469929503, 5333.546648534879, 3859.07382228266, 3996.4005399190064, 5351.518363347298, 5378.381486129087, 5583.218349431083, 5673.063944449161, 5728.828135155952, 5758.280214973129, 5771.451712087366, 5783.248177736909, 5569.498745112939, 5715.857103572403, 5733.999999999979, 5775.27809023872, 5787.88424231513, 5102.438731739506, 5105.336306280197, 5114.974425127888, 5116.616253780981, 5119.718415487147, 18974.905125474423, 20229.0, 20361.592768144554, 20425.795742042537, 20427.5914481711, 2002.8898410587412, 2046.1508473983429, 2060.1347434077575, 2070.565181311926, 2165.761766205716, 12780.552680656132, 13154.802677959839, 13160.14459060158, 13288.468461261538, 13536.729265414735, 1774.7692799936056, 1816.2553353125156, 1848.898310592917, 1879.821416965386, 1899.7435346228222, 58291.70854145745, 60324.69837650828, 60324.99999999956, 61304.38695613076, 62085.37914620886, 9541.904580954102, 9672.70981870545, 9832.852507212398, 9845.55694993727, 9910.504474776233, 12220.450079746433, 12269.57056503018, 12290.75418491643, 12296.385180740926, 12299.631011069681, 7121.537100088478, 7161.319674630901, 7169.856602867913, 7223.674934627849, 7334.156571994289, 6917.446604271646, 6939.583624982416, 6970.965145174343, 6998.895016574756, 7026.297370262932, 4033.3344998075577, 4188.68584856137, 4254.808533615995, 4279.743215407086, 4335.501417337046, 1708.180073564696, 1754.9385771498191, 1759.2874885671324, 1779.6084861330487, 1843.4008947092248, 442.09150196346815, 443.10271699808146, 462.6715032327018, 948.4262021476907, 982.9066238707311, 10459.738506537398, 10809.35143891369, 16208.918955405383, 16846.24191911367, 17592.912035439742, 807.6890397197121, 943.565959658551, 950.7575568230058, 992.513668302541, 1016.7000734783256, 9002.819943601091, 9030.909690903007, 9123.954380228057, 9245.214156796614, 9472.0, 525497.0, 533137.0, 536261.0, 537911.0, 578128.0, 67800.6609966947, 68669.31330686629, 69604.6519767408, 77638.0, 81700.59149704213, 1105.8230683090828, 1130.2822707580744, 1134.177721152158, 1134.8127558952845, 1148.936808475542, 15157.696846062796, 15223.391064357302, 15398.769018464507, 15408.0, 15764.921175394049, 34131.317373652884, 34580.48129278113, 35206.516578796334, 35399.82300088483, 36002.8199858999, 46017.0, 46949.530504694514, 47452.525474746195, 48560.0, 51018.74490627523, 9098.499582523025, 9366.250699943852, 9419.0, 9439.339246252972, 9441.905580944103, 11238.887611123784, 16089.436869709503, 16859.15704214809, 17247.102818690186, 17340.566485837953, 14207.431702731776, 14214.715705685621, 14332.856671433152, 14605.342759575633, 14678.266086695408, 13869.722605548035, 14000.859991399955, 14072.0, 14110.36503357331, 14616.342264597906, 11399.601013964471, 11586.362750048827, 12551.435185416496, 12584.182028168507, 14666.19335936491, 8740.694075707319, 8763.386562940534, 8808.691695790616, 8883.111688831064, 9307.162355388047, 13292.800607991081, 13352.265625390697, 13472.932635336761, 13571.728565428833, 14428.278586070865], "unit": "score", "name": "jquery.html", "value": 8618.371434037343}, {"lowerIsBetter": false, "replicates": [1281.0840249221806, 1437.769956806911, 1441.106513961344, 1573.9606509837254, 1786.7319902014697, 6873.106496155506, 7481.064866891638, 7583.50707204032, 7587.20334364892, 7598.164201937796, 7408.185099639036, 7645.350145237648, 7651.923480765205, 7665.1951545087795, 7676.1939996300425, 1917.1468696430095, 1950.4148755373403, 2191.0, 2254.233560589399, 2290.896909639062, 2237.4518243030398, 2244.62963611004, 2247.763984781599, 2248.123231939545, 2249.966250506244, 2121.66053431451, 2192.090282532747, 2197.8681279123302, 2199.8790066546335, 2202.735671719396, 2195.242641288753, 2209.2709405896017, 2229.687843701875, 2264.671622614728, 2266.5693518231647, 2234.597772400967, 2242.275635103357, 2269.6822444857735, 2273.1589311954517, 2332.055517515409, 7581.0, 7593.9240607593765, 7616.695332186706, 7704.768856934301, 7716.189800070968, 4380.452443444569, 4476.104779044172, 4492.550744925514, 4496.4829044659955, 4496.775161241925, 2891.8698658560415, 2961.452131355706, 3009.969900300991, 3025.9243518911985, 3027.6820933802073, 911.0707078779674, 916.3768637326615, 938.938968967015, 949.0888746803078, 952.0431965874252, 10613.5223914924, 10634.840477392845, 10703.892961070367, 10731.892681073168, 10763.515641796137, 4143.937840932388, 4185.560516145822, 4226.239276930182, 4238.724482908601, 4241.257779888569, 9204.355695101278, 9244.121808428188, 9262.95368523153, 9275.58259878307, 9286.442813431217, 4611.677182597253, 4629.745364004944, 4635.490096089427, 4639.118567472169, 4646.535346465326, 4179.247735407595, 4206.621404073648, 4217.40956266123, 4217.746935183899, 4219.493660760667, 3418.6410426904818, 3458.6368431314854, 3652.214773823641, 3682.410814269704, 3718.535183102112, 1185.608749112808, 1192.0212447337378, 1211.5941159711595, 1218.1594699657207, 1222.5904322052213, 865.359633870931, 868.1665601023088, 868.5700578213824, 877.5568337989274, 948.9952550237205, 7026.191987921352, 7085.787426377217, 7086.645667716697, 7096.609686467294, 7099.183593886769, 1056.5668076088766, 1058.7088550648634, 1068.7862427514528, 1083.7724077943562, 1103.1836441033738, 5537.031019571559, 5561.416051314634, 5567.526760225345, 5571.0, 5616.6068375213345, 8989.235914947303, 9013.864792028126, 9226.40028398152, 9291.95354023239, 9401.341906066646, 9396.718098457057, 9398.389104708172, 9403.670871519464, 9408.200302974186, 9410.482423466776, 6837.487188460886, 6952.2352541220425, 6956.686949087303, 7269.7455589054125, 7374.668139933716, 7185.497015208885, 7196.208417074013, 7223.2415596361625, 7227.891581626385, 7235.674394652358, 7969.800754981172, 8151.307138893023, 8172.5913704315735, 8310.501369917823, 8320.750377488685, 8338.541380224146, 8413.705520307005, 8587.355948303777, 8599.613017414356, 8610.311175105851, 6828.419584335188, 6930.930690693231, 7045.612491313027, 7065.470089743187, 7076.25699301566, 6463.224413070461, 6537.084808126961, 6906.412954898688, 6911.723531058701, 6939.271376505596, 6442.226932768098, 6660.234073081658, 6669.2997235289595, 6681.899771503334, 6843.520953533404, 6310.053491976057, 6397.616143031433, 6441.838954026187, 6514.6416947068365, 6554.573952693059, 6492.156019717407, 6492.610443373413, 6520.543561950618, 6521.902171467526, 6535.019747037983, 6187.474064704551, 6192.287886892885, 6195.101710252078, 6262.624242545462, 6271.749130034747, 6191.288001879841, 6300.71646775887, 6322.0, 6323.7786677466065, 6328.746850125944], "unit": "score", "name": "mootools.html", "value": 4340.205547107141}, {"lowerIsBetter": false, "replicates": [336.6936088159774, 341.40084152312687, 343.1010751830205, 349.2003312414571, 349.7604141163303, 5869.911951320728, 5909.970450147754, 5950.137230101638, 5954.285485741706, 5974.761009559623, 5593.8601534961645, 5659.122835960433, 5723.742431590578, 5810.24466819314, 5835.766569337221, 4530.61489773368, 4537.954620453786, 4544.977275113636, 4552.066826300609, 4563.840265590705, 4353.782310884443, 4545.2954792007295, 4549.499555048942, 4557.02024064826, 4559.749213793257, 4375.934360984587, 4389.4513185851765, 4453.84411545596, 4466.0844526871915, 4467.687261891669, 4416.514183439819, 4417.4919884213405, 4420.911581768379, 4438.866833994969, 4440.467143942716, 3927.842886284574, 3936.960630393688, 3942.4086387041884, 3947.3092208863336, 3954.6638535724496, 5485.314335708036, 5571.13647384656, 5584.832455026315, 5587.329520457572, 5591.0495215813, 5225.137852254374, 5237.633365664405, 5239.449857764956, 5240.842774716764, 5249.370075590915, 6175.845603859894, 6183.598066125687, 6187.81436556904, 6188.947878860605, 6194.5354098442795, 4364.432623758891, 4388.363687265329, 4393.055493069006, 4394.6923715339935, 4406.449193850769, 6343.080253363237, 6449.0, 6468.094466774608, 6482.773102941422, 6490.0589414534625, 4494.16857881293, 4497.370368148462, 4502.099580083996, 4502.257127573914, 4505.774711264424, 4585.037142200109, 4587.288970209623, 4587.610053145453, 4588.977055114703, 4589.862304130881, 5234.26720259164, 5243.659162154448, 5246.658967167198, 5253.921191182136, 5254.211868219798, 6104.572679912452, 6259.311475737665, 6267.467265282502, 6268.717907694165, 6268.968655156695, 1619.0609446521225, 1640.2536845735162, 1641.0809946430038, 1641.630633107565, 1641.8850680452254, 1097.4238524774398, 1109.384291718088, 1116.3748300951493, 1121.0695123047851, 1141.8915203055863, 5885.382034886361, 5913.58604897653, 5917.940820591825, 5920.141579470953, 5924.081767326072, 6440.581362211441, 6440.8389790255615, 6441.066045423388, 6442.389402649338, 6445.581037232565, 5755.6834374108985, 5846.619969701956, 5892.292924849045, 5895.027320492157, 5901.439363260483, 3481.7388695847912, 3519.0, 3524.8061356625117, 3526.453399723047, 3527.770694904823, 6769.05233267343, 6773.627450490172, 6780.542183430487, 6782.796516104525, 6784.694688739019, 6512.381323774234, 6636.0, 6653.4677225821815, 6654.0, 6655.0, 6742.0224067509935, 6746.123004009447, 6748.055272261888, 6751.426128779109, 6759.459243260528, 6478.902816457851, 6488.870222595616, 6499.740010399721, 6506.0, 6507.609543427409, 6267.561270711007, 6422.967885160544, 6433.5496515243485, 6438.774642887476, 6442.742290308335, 6719.630420326929, 6730.764423245163, 6763.695633696397, 6764.966175169093, 6767.35710107539, 4533.297338912474, 4533.727976321431, 4537.251353526631, 4539.182947069559, 4543.727376357429, 6357.777477788255, 6487.935120648922, 6510.056041873996, 6512.674366281762, 6515.087887695631, 6335.0, 6341.936580634319, 6345.333739957238, 6346.143270658402, 6349.174607301022, 6295.055741638791, 6304.432601065742, 6308.243010838729, 6344.080108384166, 6345.302016778059, 6054.878902422015, 6180.536459765445, 6213.937860621336, 6221.875562488634, 6225.6926045530945, 6356.0465930109, 6361.045843123568, 6361.395667411589, 6366.4588509977175, 6371.74513019474, 6179.073139029181, 6213.2233470816145, 6226.12834203221, 6227.4395304421005, 6228.439440450381], "unit": "score", "name": "prototype.html", "value": 4747.228066307478}, {"lowerIsBetter": false, "replicates": [563.3633993587246, 639.2871947778228, 649.5258461323234, 678.1049015299805, 685.2633419074494, 12783.169094008883, 12999.740005199903, 13008.284544350068, 13011.0, 13018.088733788638, 11192.272502287366, 11254.155938304619, 11606.187566870301, 11674.0, 12116.939415302912, 787.1577412168967, 793.309820456204, 800.3197282310048, 800.5076877720219, 803.2048272210528, 788.8185717285028, 799.077065988781, 799.4363973398769, 800.9399295052865, 801.7033697531922, 827.3711978896052, 842.1788755962917, 842.5155535567043, 844.0462277626305, 848.6350869126273, 837.8826964225013, 840.8108175660458, 845.1252953193446, 845.9407841451101, 846.4582667093065, 614.7878981751288, 619.2228752915063, 621.0, 621.2824188062795, 622.3745136138152, 11564.94217528907, 11702.473388697528, 11724.58963936258, 11761.529538818437, 11776.352300623463, 8850.336224783103, 9029.503377314246, 11057.225994180411, 11119.110471162368, 11239.66281011571, 8524.57377131141, 8839.29285657146, 9224.492652904088, 9261.120193581599, 9460.763480912963, 3382.9323413531592, 3457.6888080072663, 3469.5663042119736, 3499.142710036032, 3499.597546282185, 45327.77336113298, 46631.06737865224, 46789.0, 47928.76035619834, 47997.0, 8638.784030399165, 8816.426932249384, 8902.599383027778, 8964.0, 9038.954805225932, 16214.189290535425, 16216.59458513523, 16226.837731622769, 16230.0, 16247.837521624633, 7033.753818616324, 7242.96378518104, 7447.143578488543, 7460.850782984418, 7516.24837516255, 4177.4569305990635, 4189.874303770892, 4197.202531519001, 4204.0, 4226.281532139482, 2961.703829617064, 3004.4141392428705, 3006.2033561106323, 3009.232645675339, 3009.623797025372, 503.42860852931454, 521.7000224870715, 527.1854984049653, 539.5575627985093, 556.5408537956203, 456.79900843628695, 457.90384019355645, 461.9099275641285, 476.6639519138999, 489.1415565682276, 7234.529755565872, 7388.963055184797, 7397.746295879891, 7647.655855486517, 7664.65509052094, 450.794888325811, 498.81045202822696, 525.2777431032331, 536.409949056043, 540.2517513244185, 3569.3575156471566, 3601.549806274216, 3626.111602657366, 3732.309522738302, 3984.183242435294, 49616.50383496191, 49979.0, 50246.24630630543, 52813.47186528162, 53676.463235367926, 42843.35734963978, 44005.33991990123, 48110.51889481131, 48165.0, 48233.0, 42890.571094289284, 44020.77989610031, 44411.777941110086, 44570.77714611406, 45161.32258016132, 7737.497062690907, 8249.587520624065, 8394.0, 8530.658773648984, 8559.443636163878, 33603.49594756032, 34162.65837341595, 34524.0, 34772.478412824334, 35265.29469410546, 42516.0, 43275.567244327154, 43323.0, 44303.556964431235, 44868.10263794771, 9345.532723363669, 9625.614975401186, 10159.542820572944, 10601.628942986958, 10776.838347424638, 11031.172662050218, 11149.163812713916, 11151.944240278746, 11154.107671386108, 11163.0, 9473.621055157717, 9618.0, 9654.662086826927, 9713.854292185764, 9806.411615303105, 10104.343217690826, 10200.897991019994, 10391.168706503613, 10397.272190946562, 10434.37393756377, 10348.228964280437, 10572.735681607714, 10592.788144237225, 10661.0, 10793.188360559094, 8785.736427906917, 8880.777980550538, 8965.193132617835, 9397.154256116983, 9462.0, 9119.190648110845, 9267.258619310303, 9272.536373181449, 9285.303602229995, 9354.158125768714], "unit": "score", "name": "yui.html", "value": 5793.982532911258}], "name": "dromaeo_css", "value": 6741.834714252808}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 111.0, 111.0, 111.0, 100.0, 109.0, 109.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 124.0, 150.0, 162.0, 130.0, 153.0, 156.0, 126.0, 178.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 160.0, 159.0, 162.0, 162.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 87.0, 97.0, 70.0, 73.0, 72.0, 119.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [105.0, 97.0, 139.0, 96.0, 98.0, 97.0, 140.0, 97.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 57.0, 57.0, 57.0, 56.0, 55.0, 64.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 86.0, 86.0, 86.0, 92.0, 85.0, 85.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [122.0, 122.0, 122.0, 116.0, 116.0, 115.0, 118.0, 125.0, 125.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [151.0, 142.0, 149.0, 148.0, 150.0, 148.0, 149.0, 141.0, 149.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 70.0, 69.0, 73.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1504.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [194.06171162429652], "unit": "score", "name": "DeltaBlue", "value": 340.70605400000017}, {"lowerIsBetter": false, "replicates": [283.7684449489217], "unit": "score", "name": "Encrypt", "value": 938.0218440000002}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [578.7037037037037], "unit": "score", "name": "Splay", "value": 140.81644799999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19764.982824138453}]} 19:57:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19764.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1504.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6741.84"}}} 19:57:27 INFO - Return code: 0 19:57:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:57:27 INFO - # TBPL SUCCESS # 19:57:27 INFO - Running post-action listener: _resource_record_post_action 19:57:27 INFO - Running post-run listener: _resource_record_post_run 19:57:28 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 69632; Write bytes: 545939456; Read time: 12; Write time: 528076 19:57:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234823680; Read time: 0; Write time: 292600 19:57:28 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 69632; Write bytes: 304119808; Read time: 12; Write time: 234528 19:57:28 INFO - Running post-run listener: _upload_blobber_files 19:57:28 INFO - Blob upload gear active. 19:57:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:57:28 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 19:57:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:57:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:57:28 INFO - (blobuploader) - INFO - Open directory for files ... 19:57:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:57:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:57:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:57:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:57:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:57:29 INFO - (blobuploader) - INFO - Done attempting. 19:57:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:57:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:57:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:57:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:57:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:57:30 INFO - (blobuploader) - INFO - Done attempting. 19:57:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:57:30 INFO - Return code: 0 19:57:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:57:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:57:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/033eb6b1a9cf1590b31c1207777fa8e4500a48304ef85289bf379131cea0dee4d768580a53d963eb97377de6405334cac7e22a0f21af2ed9f3e7d662d342064d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c25fd5b01c1b84cfb3abb9e5c5fbcb2d3051ca7d20c7fcabee0c516a0d6a19e77cb9e33190f744ed127b4b1c9b1440973b52b78d21b3f9da12123cfe2b08f4c"} 19:57:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:57:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:57:30 INFO - Contents: 19:57:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/033eb6b1a9cf1590b31c1207777fa8e4500a48304ef85289bf379131cea0dee4d768580a53d963eb97377de6405334cac7e22a0f21af2ed9f3e7d662d342064d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c25fd5b01c1b84cfb3abb9e5c5fbcb2d3051ca7d20c7fcabee0c516a0d6a19e77cb9e33190f744ed127b4b1c9b1440973b52b78d21b3f9da12123cfe2b08f4c"} 19:57:30 INFO - Copying logs to upload dir... 19:57:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.900652 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-04 19:57:30.320547) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 19:57:30.324452) ========= 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=db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/033eb6b1a9cf1590b31c1207777fa8e4500a48304ef85289bf379131cea0dee4d768580a53d963eb97377de6405334cac7e22a0f21af2ed9f3e7d662d342064d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c25fd5b01c1b84cfb3abb9e5c5fbcb2d3051ca7d20c7fcabee0c516a0d6a19e77cb9e33190f744ed127b4b1c9b1440973b52b78d21b3f9da12123cfe2b08f4c"} build_url:https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/cgHwmTnTTxO80y7Fam8Hkg/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/Fx-Team/sha512/033eb6b1a9cf1590b31c1207777fa8e4500a48304ef85289bf379131cea0dee4d768580a53d963eb97377de6405334cac7e22a0f21af2ed9f3e7d662d342064d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c25fd5b01c1b84cfb3abb9e5c5fbcb2d3051ca7d20c7fcabee0c516a0d6a19e77cb9e33190f744ed127b4b1c9b1440973b52b78d21b3f9da12123cfe2b08f4c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 19:57:30.349336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 19:57:30.349657) ========= 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=db0483c52d987ecb441a263b000001ad-1451964930.277932-606273092 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 19:57:30.432923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 19:57:30.433245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 19:57:30.433529) ========= ========= Total master_lag: 0.25 =========