builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1452484712.83 results: success (0) buildid: 20160110173002 builduid: 28afae3d45264f9bb6e97f725dd11b69 revision: 55d6be76fac90e93cfd335c68b31d5e42cc158cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.830022) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.831013) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.831818) ========= 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=df17445c3590ff7897617a0e00000225-1452480755.548566-174193274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006413 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.856657) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.857032) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.870483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.870840) ========= 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=df17445c3590ff7897617a0e00000225-1452480755.548566-174193274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.920850) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.921207) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.921625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:32.921945) ========= 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=df17445c3590ff7897617a0e00000225-1452480755.548566-174193274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 19:58:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-01-10 19:58:33 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.040638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.041003) ========= 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=df17445c3590ff7897617a0e00000225-1452480755.548566-174193274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017040 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.093891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.094828) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55d6be76fac90e93cfd335c68b31d5e42cc158cd --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 55d6be76fac90e93cfd335c68b31d5e42cc158cd --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=df17445c3590ff7897617a0e00000225-1452480755.548566-174193274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 19:58:33,399 truncating revision to first 12 chars 2016-01-10 19:58:33,399 Setting DEBUG logging. 2016-01-10 19:58:33,399 attempt 1/10 2016-01-10 19:58:33,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55d6be76fac9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 19:58:33,701 unpacking tar archive at: fx-team-55d6be76fac9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600867 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.710621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.711114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.754225) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.754644) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 19:58:33.755147) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-10 19:58:33.755494) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=df17445c3590ff7897617a0e00000225-1452480755.548566-174193274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:34 INFO - MultiFileLogger online at 20160110 19:58:34 in /builds/slave/test-pgo 19:58:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:58:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:58:34 INFO - {'append_to_log': False, 19:58:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:58:34 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:58:34 INFO - 'branch': 'Fx-Team', 19:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:34 INFO - 'config_files': ('talos/linux_config.py',), 19:58:34 INFO - 'default_actions': ('clobber', 19:58:34 INFO - 'read-buildbot-config', 19:58:34 INFO - 'download-and-extract', 19:58:34 INFO - 'populate-webroot', 19:58:34 INFO - 'create-virtualenv', 19:58:34 INFO - 'install', 19:58:34 INFO - 'run-tests'), 19:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:34 INFO - 'download_minidump_stackwalk': True, 19:58:34 INFO - 'download_symbols': 'ondemand', 19:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:34 INFO - 'installer_path': 'installer.exe', 19:58:34 INFO - 'log_level': 'info', 19:58:34 INFO - 'log_name': 'talos', 19:58:34 INFO - 'log_to_console': True, 19:58:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:34 INFO - 'opt_config_files': (), 19:58:34 INFO - 'pip_index': False, 19:58:34 INFO - 'sps_profile': False, 19:58:34 INFO - 'sps_profile_interval': 0, 19:58:34 INFO - 'suite': 'dromaeojs-e10s', 19:58:34 INFO - 'system_bits': '32', 19:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:34 INFO - 'title': 'talos-linux64-ix-021', 19:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:34 INFO - 'use_talos_json': True, 19:58:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:34 INFO - 'work_dir': 'build'} 19:58:34 INFO - ##### 19:58:34 INFO - ##### Running clobber step. 19:58:34 INFO - ##### 19:58:34 INFO - Running pre-action listener: _resource_record_pre_action 19:58:34 INFO - Running main action method: clobber 19:58:34 INFO - rmtree: /builds/slave/test-pgo/build 19:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:58:34 INFO - Running post-action listener: _resource_record_post_action 19:58:34 INFO - ##### 19:58:34 INFO - ##### Running read-buildbot-config step. 19:58:34 INFO - ##### 19:58:34 INFO - Running pre-action listener: _resource_record_pre_action 19:58:34 INFO - Running main action method: read_buildbot_config 19:58:34 INFO - Using buildbot properties: 19:58:34 INFO - { 19:58:34 INFO - "project": "", 19:58:34 INFO - "product": "firefox", 19:58:34 INFO - "script_repo_revision": "production", 19:58:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:58:34 INFO - "repository": "", 19:58:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:58:34 INFO - "buildid": "20160110173002", 19:58:34 INFO - "pgo_build": "True", 19:58:34 INFO - "basedir": "/builds/slave/test-pgo", 19:58:34 INFO - "buildnumber": 195, 19:58:34 INFO - "slavename": "talos-linux64-ix-021", 19:58:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:58:34 INFO - "platform": "ubuntu64_hw", 19:58:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:34 INFO - "branch": "fx-team", 19:58:34 INFO - "repo_path": "integration/fx-team", 19:58:34 INFO - "revision": "55d6be76fac90e93cfd335c68b31d5e42cc158cd", 19:58:34 INFO - "stage_platform": "linux64-pgo", 19:58:34 INFO - "builduid": "28afae3d45264f9bb6e97f725dd11b69", 19:58:34 INFO - "slavebuilddir": "test" 19:58:34 INFO - } 19:58:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:58:34 INFO - Running post-action listener: _resource_record_post_action 19:58:34 INFO - ##### 19:58:34 INFO - ##### Running download-and-extract step. 19:58:34 INFO - ##### 19:58:34 INFO - Running pre-action listener: _resource_record_pre_action 19:58:34 INFO - Running main action method: download_and_extract 19:58:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:58: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:58:34 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json 19:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json 19:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:58:35 INFO - Downloaded 1302 bytes. 19:58:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:58:35 INFO - Using the following test package requirements: 19:58:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:35 INFO - u'jsshell-linux-x86_64.zip'], 19:58:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:35 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/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:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/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:58:40 INFO - Downloaded 24029761 bytes. 19:58:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:58:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:58:41 INFO - Return code: 0 19:58:41 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:58: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:58:41 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/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:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/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:58:49 INFO - Downloaded 24029761 bytes. 19:58:49 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:58:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:49 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:58:50 INFO - Return code: 0 19:58: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:58:50 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/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:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/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:58:54 INFO - Downloaded 11132285 bytes. 19:58:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:58:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:58:54 INFO - Return code: 0 19:58: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:58:54 INFO - https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:58:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/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:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W9q1xNFtTrajvqSKXlrR-g/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:58:57 INFO - Downloaded 55909247 bytes. 19:58:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:57 INFO - mkdir: /builds/slave/test-pgo/properties 19:58:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:58:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:58:57 INFO - Contents: 19:58:57 INFO - build_url:https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:57 INFO - Running post-action listener: _resource_record_post_action 19:58:57 INFO - Running post-action listener: set_extra_try_arguments 19:58:57 INFO - ##### 19:58:57 INFO - ##### Running populate-webroot step. 19:58:57 INFO - ##### 19:58:57 INFO - Running pre-action listener: _resource_record_pre_action 19:58:57 INFO - Running main action method: populate_webroot 19:58:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:57 INFO - '--tppagecycles', 19:58:57 INFO - '7'], 19:58:57 INFO - 'tests': ['tsvgm']}}, 19:58:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:58:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:57 INFO - 'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:57 INFO - 'tests': ['damp', 'tps']}, 19:58:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:57 INFO - 'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['damp', 'tps']}, 19:58:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:58:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:57 INFO - 'other': {'tests': ['a11yr', 19:58:57 INFO - 'ts_paint', 19:58:57 INFO - 'tpaint', 19:58:57 INFO - 'sessionrestore', 19:58:57 INFO - 'sessionrestore_no_auto_restore']}, 19:58:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['a11yr', 19:58:57 INFO - 'ts_paint', 19:58:57 INFO - 'tpaint', 19:58:57 INFO - 'sessionrestore', 19:58:57 INFO - 'sessionrestore_no_auto_restore']}, 19:58:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['a11yr', 19:58:57 INFO - 'ts_paint', 19:58:57 INFO - 'tpaint', 19:58:57 INFO - 'sessionrestore', 19:58:57 INFO - 'sessionrestore_no_auto_restore']}, 19:58:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['a11yr', 19:58:57 INFO - 'ts_paint', 19:58:57 INFO - 'tpaint', 19:58:57 INFO - 'sessionrestore', 19:58:57 INFO - 'sessionrestore_no_auto_restore']}, 19:58:57 INFO - 'other_l64': {'tests': ['a11yr', 19:58:57 INFO - 'ts_paint', 19:58:57 INFO - 'tpaint', 19:58:57 INFO - 'sessionrestore', 19:58:57 INFO - 'sessionrestore_no_auto_restore']}, 19:58:57 INFO - 'other_nol64': {'tests': ['a11yr', 19:58:57 INFO - 'ts_paint', 19:58:57 INFO - 'tpaint', 19:58:57 INFO - 'sessionrestore', 19:58:57 INFO - 'sessionrestore_no_auto_restore']}, 19:58:57 INFO - 'svgr': {'tests': ['tsvgx', 19:58:57 INFO - 'tsvgr_opacity', 19:58:57 INFO - 'tart', 19:58:57 INFO - 'tscrollx', 19:58:57 INFO - 'cart']}, 19:58:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['tsvgx', 19:58:57 INFO - 'tsvgr_opacity', 19:58:57 INFO - 'tart', 19:58:57 INFO - 'tscrollx', 19:58:57 INFO - 'cart']}, 19:58:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:57 INFO - 'tests': ['tp5o']}, 19:58:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:57 INFO - 'talos_options': ['--e10s'], 19:58:57 INFO - 'tests': ['tp5o']}, 19:58:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:57 INFO - 'talos_options': ['--xperf_path', 19:58:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:57 INFO - 'tests': ['tp5n']}, 19:58:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:57 INFO - 'talos_options': ['--e10s', 19:58:57 INFO - '--xperf_path', 19:58:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:57 INFO - 'tests': ['tp5n']}}, 19:58:57 INFO - 'talos.zip': {'path': '', 19:58:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:57 INFO - Running post-action listener: _resource_record_post_action 19:58:57 INFO - ##### 19:58:57 INFO - ##### Running create-virtualenv step. 19:58:57 INFO - ##### 19:58:57 INFO - Running pre-action listener: _resource_record_pre_action 19:58:57 INFO - Running main action method: create_virtualenv 19:58:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:58:57 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:58:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:58:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:57 INFO - Using real prefix '/usr' 19:58:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:58:58 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:00 INFO - Installing pip.................done. 19:59:00 INFO - Return code: 0 19:59:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:00 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:59:00 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:59:00 INFO - Using env: {'DISPLAY': ':0', 19:59:00 INFO - 'HOME': '/home/cltbld', 19:59:00 INFO - 'LANG': 'en_US.UTF-8', 19:59:00 INFO - 'LANGUAGE': 'en_US:en', 19:59:00 INFO - 'LOGNAME': 'cltbld', 19:59:00 INFO - 'MAIL': '/var/mail/cltbld', 19:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:00 INFO - 'MOZ_NO_REMOTE': '1', 19:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:00 INFO - 'NO_EM_RESTART': '1', 19:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:00 INFO - 'SHELL': '/bin/bash', 19:59:00 INFO - 'SHLVL': '1', 19:59:00 INFO - 'TERM': 'linux', 19:59:00 INFO - 'TMOUT': '86400', 19:59:00 INFO - 'USER': 'cltbld', 19:59:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:00 INFO - '_': '/tools/buildbot/bin/python'} 19:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:00 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:59:00 INFO - Cleaning up... 19:59:00 INFO - Return code: 0 19:59:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:00 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:59:00 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:59:00 INFO - Using env: {'DISPLAY': ':0', 19:59:00 INFO - 'HOME': '/home/cltbld', 19:59:00 INFO - 'LANG': 'en_US.UTF-8', 19:59:00 INFO - 'LANGUAGE': 'en_US:en', 19:59:00 INFO - 'LOGNAME': 'cltbld', 19:59:00 INFO - 'MAIL': '/var/mail/cltbld', 19:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:00 INFO - 'MOZ_NO_REMOTE': '1', 19:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:00 INFO - 'NO_EM_RESTART': '1', 19:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:00 INFO - 'SHELL': '/bin/bash', 19:59:00 INFO - 'SHLVL': '1', 19:59:00 INFO - 'TERM': 'linux', 19:59:00 INFO - 'TMOUT': '86400', 19:59:00 INFO - 'USER': 'cltbld', 19:59:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:00 INFO - '_': '/tools/buildbot/bin/python'} 19:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:00 INFO - Downloading/unpacking psutil>=0.7.1 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:02 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:59:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:59:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:02 INFO - Installing collected packages: psutil 19:59:02 INFO - Running setup.py install for psutil 19:59:02 INFO - building 'psutil._psutil_linux' extension 19:59:02 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:59:02 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:59:02 INFO - building 'psutil._psutil_posix' extension 19:59:02 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:59:02 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:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:02 INFO - Successfully installed psutil 19:59:02 INFO - Cleaning up... 19:59:02 INFO - Return code: 0 19:59:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:59:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:59:02 INFO - Using env: {'DISPLAY': ':0', 19:59:02 INFO - 'HOME': '/home/cltbld', 19:59:02 INFO - 'LANG': 'en_US.UTF-8', 19:59:02 INFO - 'LANGUAGE': 'en_US:en', 19:59:02 INFO - 'LOGNAME': 'cltbld', 19:59:02 INFO - 'MAIL': '/var/mail/cltbld', 19:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:02 INFO - 'MOZ_NO_REMOTE': '1', 19:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:02 INFO - 'NO_EM_RESTART': '1', 19:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:02 INFO - 'SHELL': '/bin/bash', 19:59:02 INFO - 'SHLVL': '1', 19:59:02 INFO - 'TERM': 'linux', 19:59:02 INFO - 'TMOUT': '86400', 19:59:02 INFO - 'USER': 'cltbld', 19:59:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:02 INFO - '_': '/tools/buildbot/bin/python'} 19:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:04 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:59:04 INFO - Installing collected packages: mozsystemmonitor 19:59:04 INFO - Running setup.py install for mozsystemmonitor 19:59:05 INFO - Successfully installed mozsystemmonitor 19:59:05 INFO - Cleaning up... 19:59:05 INFO - Return code: 0 19:59:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:59:05 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:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:05 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:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:05 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 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:05 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:59:05 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:59:05 INFO - Using env: {'DISPLAY': ':0', 19:59:05 INFO - 'HOME': '/home/cltbld', 19:59:05 INFO - 'LANG': 'en_US.UTF-8', 19:59:05 INFO - 'LANGUAGE': 'en_US:en', 19:59:05 INFO - 'LOGNAME': 'cltbld', 19:59:05 INFO - 'MAIL': '/var/mail/cltbld', 19:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:05 INFO - 'MOZ_NO_REMOTE': '1', 19:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:05 INFO - 'NO_EM_RESTART': '1', 19:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:05 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:05 INFO - 'SHELL': '/bin/bash', 19:59:05 INFO - 'SHLVL': '1', 19:59:05 INFO - 'TERM': 'linux', 19:59:05 INFO - 'TMOUT': '86400', 19:59:05 INFO - 'USER': 'cltbld', 19:59:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:05 INFO - '_': '/tools/buildbot/bin/python'} 19:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:05 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:07 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:59:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:59:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:59:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:08 INFO - Downloading docopt-0.6.1.tar.gz 19:59:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:59:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:08 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:08 INFO - Running setup.py install for blobuploader 19:59:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:59:08 INFO - Running setup.py install for requests 19:59:09 INFO - Running setup.py install for docopt 19:59:09 INFO - Successfully installed blobuploader requests docopt 19:59:09 INFO - Cleaning up... 19:59:09 INFO - Return code: 0 19:59:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:09 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 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:09 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:59:09 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:59:09 INFO - Using env: {'DISPLAY': ':0', 19:59:09 INFO - 'HOME': '/home/cltbld', 19:59:09 INFO - 'LANG': 'en_US.UTF-8', 19:59:09 INFO - 'LANGUAGE': 'en_US:en', 19:59:09 INFO - 'LOGNAME': 'cltbld', 19:59:09 INFO - 'MAIL': '/var/mail/cltbld', 19:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:09 INFO - 'MOZ_NO_REMOTE': '1', 19:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:09 INFO - 'NO_EM_RESTART': '1', 19:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:09 INFO - 'SHELL': '/bin/bash', 19:59:09 INFO - 'SHLVL': '1', 19:59:09 INFO - 'TERM': 'linux', 19:59:09 INFO - 'TMOUT': '86400', 19:59:09 INFO - 'USER': 'cltbld', 19:59:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:09 INFO - '_': '/tools/buildbot/bin/python'} 19:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:09 INFO - Running setup.py (path:/tmp/pip-QBsUkD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:09 INFO - Running setup.py (path:/tmp/pip-F84upI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:09 INFO - Running setup.py (path:/tmp/pip-1IBwta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:09 INFO - Running setup.py (path:/tmp/pip-BAexWD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:09 INFO - Running setup.py (path:/tmp/pip-NI1ENR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:09 INFO - Running setup.py (path:/tmp/pip-yf9Slu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:09 INFO - Running setup.py (path:/tmp/pip-mQ_RAZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:10 INFO - Running setup.py (path:/tmp/pip-NGOEVU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:10 INFO - Running setup.py (path:/tmp/pip-Jduh8W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:10 INFO - Running setup.py (path:/tmp/pip-iGdFOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:10 INFO - Running setup.py (path:/tmp/pip-NuZvGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:10 INFO - Running setup.py (path:/tmp/pip-h4OepC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:10 INFO - Running setup.py (path:/tmp/pip-t9mc1f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:10 INFO - Running setup.py (path:/tmp/pip-lLOcQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:10 INFO - Running setup.py (path:/tmp/pip-sTgRSD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:10 INFO - Running setup.py (path:/tmp/pip-g1oEu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:10 INFO - Running setup.py (path:/tmp/pip-_QYGzM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:10 INFO - Running setup.py install for manifestparser 19:59:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:59:10 INFO - Running setup.py install for mozcrash 19:59:10 INFO - Running setup.py install for mozdebug 19:59:11 INFO - Running setup.py install for mozdevice 19:59:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Running setup.py install for mozfile 19:59:11 INFO - Running setup.py install for mozhttpd 19:59:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Running setup.py install for mozinfo 19:59:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Running setup.py install for mozInstall 19:59:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Running setup.py install for mozleak 19:59:11 INFO - Running setup.py install for mozlog 19:59:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Running setup.py install for moznetwork 19:59:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:59:11 INFO - Running setup.py install for mozprocess 19:59:11 INFO - Running setup.py install for mozprofile 19:59:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Running setup.py install for mozrunner 19:59:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Running setup.py install for mozscreenshot 19:59:12 INFO - Running setup.py install for moztest 19:59:12 INFO - Running setup.py install for mozversion 19:59:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:59:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:12 INFO - Cleaning up... 19:59:12 INFO - Return code: 0 19:59:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:12 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:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 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:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:12 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 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:12 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:59:12 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:59:12 INFO - Using env: {'DISPLAY': ':0', 19:59:12 INFO - 'HOME': '/home/cltbld', 19:59:12 INFO - 'LANG': 'en_US.UTF-8', 19:59:12 INFO - 'LANGUAGE': 'en_US:en', 19:59:12 INFO - 'LOGNAME': 'cltbld', 19:59:12 INFO - 'MAIL': '/var/mail/cltbld', 19:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:12 INFO - 'MOZ_NO_REMOTE': '1', 19:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:12 INFO - 'NO_EM_RESTART': '1', 19:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:12 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:12 INFO - 'SHELL': '/bin/bash', 19:59:12 INFO - 'SHLVL': '1', 19:59:12 INFO - 'TERM': 'linux', 19:59:12 INFO - 'TMOUT': '86400', 19:59:12 INFO - 'USER': 'cltbld', 19:59:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:12 INFO - '_': '/tools/buildbot/bin/python'} 19:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:12 INFO - Running setup.py (path:/tmp/pip-uPaBYh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:12 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:59:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:12 INFO - Running setup.py (path:/tmp/pip-aW8S7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:12 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:59:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:12 INFO - Running setup.py (path:/tmp/pip-DeW1gh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:12 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:59:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:12 INFO - Running setup.py (path:/tmp/pip-nU78U7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:13 INFO - Running setup.py (path:/tmp/pip-gpzNn9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:13 INFO - Running setup.py (path:/tmp/pip-jWHWL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:13 INFO - Running setup.py (path:/tmp/pip-YDvD5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:13 INFO - Running setup.py (path:/tmp/pip-icjqiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:13 INFO - Running setup.py (path:/tmp/pip-2mgDgI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:13 INFO - Running setup.py (path:/tmp/pip-tpHg90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:13 INFO - Running setup.py (path:/tmp/pip-2xTdla-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:13 INFO - Running setup.py (path:/tmp/pip-kVFVj5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:13 INFO - Running setup.py (path:/tmp/pip-KFs0LA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:13 INFO - Running setup.py (path:/tmp/pip-YLQy1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:13 INFO - Running setup.py (path:/tmp/pip-9O41zR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:13 INFO - Running setup.py (path:/tmp/pip-v6aWck-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:13 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:59:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:13 INFO - Running setup.py (path:/tmp/pip-IjsIh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:13 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:59:13 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:59:13 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:59:13 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:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:59:13 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:59:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:15 INFO - Downloading blessings-1.5.1.tar.gz 19:59:15 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:59:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:59:15 INFO - Installing collected packages: blessings 19:59:15 INFO - Running setup.py install for blessings 19:59:15 INFO - Successfully installed blessings 19:59:15 INFO - Cleaning up... 19:59:16 INFO - Return code: 0 19:59:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:59:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:16 INFO - Reading from file tmpfile_stdout 19:59:16 INFO - Current package versions: 19:59:16 INFO - argparse == 1.2.1 19:59:16 INFO - blessings == 1.5.1 19:59:16 INFO - blobuploader == 1.2.4 19:59:16 INFO - docopt == 0.6.1 19:59:16 INFO - manifestparser == 1.1 19:59:16 INFO - mozInstall == 1.12 19:59:16 INFO - mozcrash == 0.16 19:59:16 INFO - mozdebug == 0.1 19:59:16 INFO - mozdevice == 0.47 19:59:16 INFO - mozfile == 1.2 19:59:16 INFO - mozhttpd == 0.7 19:59:16 INFO - mozinfo == 0.9 19:59:16 INFO - mozleak == 0.1 19:59:16 INFO - mozlog == 3.1 19:59:16 INFO - moznetwork == 0.27 19:59:16 INFO - mozprocess == 0.22 19:59:16 INFO - mozprofile == 0.28 19:59:16 INFO - mozrunner == 6.11 19:59:16 INFO - mozscreenshot == 0.1 19:59:16 INFO - mozsystemmonitor == 0.0 19:59:16 INFO - moztest == 0.7 19:59:16 INFO - mozversion == 1.4 19:59:16 INFO - psutil == 3.1.1 19:59:16 INFO - requests == 1.2.3 19:59:16 INFO - wsgiref == 0.1.2 19:59:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:16 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:59:16 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:59:16 INFO - Using env: {'DISPLAY': ':0', 19:59:16 INFO - 'HOME': '/home/cltbld', 19:59:16 INFO - 'LANG': 'en_US.UTF-8', 19:59:16 INFO - 'LANGUAGE': 'en_US:en', 19:59:16 INFO - 'LOGNAME': 'cltbld', 19:59:16 INFO - 'MAIL': '/var/mail/cltbld', 19:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:16 INFO - 'MOZ_NO_REMOTE': '1', 19:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:16 INFO - 'NO_EM_RESTART': '1', 19:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:16 INFO - 'SHELL': '/bin/bash', 19:59:16 INFO - 'SHLVL': '1', 19:59:16 INFO - 'TERM': 'linux', 19:59:16 INFO - 'TMOUT': '86400', 19:59:16 INFO - 'USER': 'cltbld', 19:59:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:16 INFO - '_': '/tools/buildbot/bin/python'} 19:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:16 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:59:16 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:59:16 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:59:16 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:59:16 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:59:16 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:59:16 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:59:16 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:59:16 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:59:16 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:59:16 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:59:16 INFO - Cleaning up... 19:59:16 INFO - Return code: 0 19:59:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:59:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:59:16 INFO - Using env: {'DISPLAY': ':0', 19:59:16 INFO - 'HOME': '/home/cltbld', 19:59:16 INFO - 'LANG': 'en_US.UTF-8', 19:59:16 INFO - 'LANGUAGE': 'en_US:en', 19:59:16 INFO - 'LOGNAME': 'cltbld', 19:59:16 INFO - 'MAIL': '/var/mail/cltbld', 19:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:16 INFO - 'MOZ_NO_REMOTE': '1', 19:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:16 INFO - 'NO_EM_RESTART': '1', 19:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:16 INFO - 'SHELL': '/bin/bash', 19:59:16 INFO - 'SHLVL': '1', 19:59:16 INFO - 'TERM': 'linux', 19:59:16 INFO - 'TMOUT': '86400', 19:59:16 INFO - 'USER': 'cltbld', 19:59:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:16 INFO - '_': '/tools/buildbot/bin/python'} 19:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:16 INFO - Downloading/unpacking jsonschema 19:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:18 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:59:18 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:18 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:59:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:18 INFO - warning: no files found matching '*.txt' 19:59:18 INFO - no previously-included directories found matching 'build' 19:59:18 INFO - no previously-included directories found matching 'dist' 19:59:18 INFO - no previously-included directories found matching '.git*' 19:59:18 INFO - Installing collected packages: jsonschema, functools32 19:59:18 INFO - Running setup.py install for functools32 19:59:18 INFO - warning: no files found matching '*.txt' 19:59:18 INFO - no previously-included directories found matching 'build' 19:59:18 INFO - no previously-included directories found matching 'dist' 19:59:18 INFO - no previously-included directories found matching '.git*' 19:59:18 INFO - Successfully installed jsonschema functools32 19:59:18 INFO - Cleaning up... 19:59:18 INFO - Return code: 0 19:59:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:59:18 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:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:18 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:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:18 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 0x7f63ceafdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b16630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, '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': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', '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:59:18 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:59:18 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:59:18 INFO - Using env: {'DISPLAY': ':0', 19:59:18 INFO - 'HOME': '/home/cltbld', 19:59:18 INFO - 'LANG': 'en_US.UTF-8', 19:59:18 INFO - 'LANGUAGE': 'en_US:en', 19:59:18 INFO - 'LOGNAME': 'cltbld', 19:59:18 INFO - 'MAIL': '/var/mail/cltbld', 19:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:18 INFO - 'MOZ_NO_REMOTE': '1', 19:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:18 INFO - 'NO_EM_RESTART': '1', 19:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:18 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:18 INFO - 'SHELL': '/bin/bash', 19:59:18 INFO - 'SHLVL': '1', 19:59:18 INFO - 'TERM': 'linux', 19:59:18 INFO - 'TMOUT': '86400', 19:59:18 INFO - 'USER': 'cltbld', 19:59:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:18 INFO - '_': '/tools/buildbot/bin/python'} 19:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:19 INFO - Downloading/unpacking flake8 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:20 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:59:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59:20 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:59:20 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:59:20 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:59:20 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:59:20 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:59:20 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:59:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:20 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:59:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59:20 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:59:20 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:59:20 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:59:20 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:59:20 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:59:20 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:59:21 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:59:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59:21 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:59:21 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:59:21 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:59:21 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:59:21 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:59:21 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:59:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:59:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:21 INFO - no previously-included directories found matching 'docs/_build' 19:59:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:21 INFO - Running setup.py install for pep8 19:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:21 INFO - no previously-included directories found matching 'docs/_build' 19:59:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:59:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:21 INFO - Cleaning up... 19:59:21 INFO - Return code: 0 19:59:21 INFO - Running post-action listener: _resource_record_post_action 19:59:21 INFO - Running post-action listener: _start_resource_monitoring 19:59:21 INFO - Starting resource monitoring. 19:59:21 INFO - ##### 19:59:21 INFO - ##### Running install step. 19:59:21 INFO - ##### 19:59:21 INFO - Running pre-action listener: _resource_record_pre_action 19:59:21 INFO - Running main action method: install 19:59:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:21 INFO - Reading from file tmpfile_stdout 19:59:21 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:59:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:59:22 INFO - Reading from file tmpfile_stdout 19:59:22 INFO - Output received: 19:59:22 INFO - Usage: mozinstall [options] installer 19:59:22 INFO - Options: 19:59:22 INFO - -h, --help show this help message and exit 19:59:22 INFO - -d DEST, --destination=DEST 19:59:22 INFO - Directory to install application into. [default: 19:59:22 INFO - "/builds/slave/test-pgo"] 19:59:22 INFO - --app=APP Application being installed. [default: firefox] 19:59:22 INFO - mkdir: /builds/slave/test-pgo/build/application 19:59:22 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:59:22 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:59:38 INFO - Reading from file tmpfile_stdout 19:59:38 INFO - Output received: 19:59:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:59:38 INFO - Running post-action listener: _resource_record_post_action 19:59:38 INFO - ##### 19:59:38 INFO - ##### Running run-tests step. 19:59:38 INFO - ##### 19:59:38 INFO - Running pre-action listener: _resource_record_pre_action 19:59:38 INFO - Running main action method: run_tests 19:59:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:59:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:59:38 INFO - Python 2.7.3 19:59:38 INFO - Return code: 0 19:59:38 INFO - grabbing minidump binary from tooltool 19:59:38 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:59:38 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 0x2ba7840>, '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 0x2b146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b14b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:59:38 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:59:38 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:59:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:38 INFO - Return code: 0 19:59:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:59:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:59:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:59:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:59:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:59:39 INFO - Return code: 0 19:59:39 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:59:39 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:59:39 INFO - Using env: {'DISPLAY': ':0', 19:59:39 INFO - 'HOME': '/home/cltbld', 19:59:39 INFO - 'LANG': 'en_US.UTF-8', 19:59:39 INFO - 'LANGUAGE': 'en_US:en', 19:59:39 INFO - 'LOGNAME': 'cltbld', 19:59:39 INFO - 'MAIL': '/var/mail/cltbld', 19:59:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:39 INFO - 'MOZ_NO_REMOTE': '1', 19:59:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:39 INFO - 'NO_EM_RESTART': '1', 19:59:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:59:39 INFO - 'SHELL': '/bin/bash', 19:59:39 INFO - 'SHLVL': '1', 19:59:39 INFO - 'TERM': 'linux', 19:59:39 INFO - 'TMOUT': '86400', 19:59:39 INFO - 'USER': 'cltbld', 19:59:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1452480755.548566-174193274', 19:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:39 INFO - '_': '/tools/buildbot/bin/python'} 19:59:39 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:59:39 INFO - mozversion application_buildid: 20160110173002 19:59:39 INFO - mozversion application_changeset: 55d6be76fac90e93cfd335c68b31d5e42cc158cd 19:59:39 INFO - mozversion application_display_name: Nightly 19:59:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:39 INFO - mozversion application_name: Firefox 19:59:39 INFO - mozversion application_remotingname: firefox 19:59:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:59:39 INFO - mozversion application_vendor: Mozilla 19:59:39 INFO - mozversion application_version: 46.0a1 19:59:39 INFO - mozversion platform_buildid: 20160110173002 19:59:39 INFO - mozversion platform_changeset: 55d6be76fac90e93cfd335c68b31d5e42cc158cd 19:59:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:39 INFO - mozversion platform_version: 46.0a1 19:59:39 INFO - using testdate: 1452484779 19:59:39 INFO - actual date: 1452484779 19:59:39 INFO - starting webserver on 'localhost:47649' 19:59:39 INFO - SUITE-START | Running 3 tests 19:59:39 INFO - TEST-START | dromaeo_css 19:59:39 INFO - operating with platform_type : linux_ 19:59:39 INFO - Initialising browser for dromaeo_css test... 19:59:39 INFO - TEST-INFO | started process 30073 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFLya5i/profile http://localhost:47649/getInfo.html) 19:59:43 INFO - PROCESS | 30073 | 19:59:43 INFO - PROCESS | 30073 | (process:30155): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:59:44 INFO - PROCESS | 30073 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 19:59:44 INFO - PROCESS | 30073 | __metrics Screen width/height:1600/1200 19:59:44 INFO - PROCESS | 30073 | colorDepth:24 19:59:44 INFO - PROCESS | 30073 | Browser inner width/height: 1024/697 19:59:44 INFO - PROCESS | 30073 | __metrics 19:59:44 INFO - PROCESS | 30073 | 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:59:45 INFO - TEST-INFO | 30073: exit 0 19:59:45 INFO - Browser initialized. 19:59:45 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:45 INFO - TEST-INFO | started process 30204 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFLya5i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:47 INFO - PROCESS | 30204 | 19:59:47 INFO - PROCESS | 30204 | (process:30265): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:59:57 INFO - PROCESS | 30204 | RSS: Main: 151416832 19:59:57 INFO - PROCESS | 30204 | 20:00:47 INFO - PROCESS | 30204 | 1452484847110 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] 20:02:55 INFO - PROCESS | 30204 | Cycle 1(1): loaded http://localhost:47649/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47649/tests/dromaeo/cssquery-ext.html) 20:02:56 INFO - PROCESS | 30204 | RSS: Main: 157462528 20:02:56 INFO - PROCESS | 30204 | 20:05:58 INFO - PROCESS | 30204 | Cycle 1(1): loaded http://localhost:47649/tests/dromaeo/cssquery-ext.html (next: http://localhost:47649/tests/dromaeo/cssquery-jquery.html) 20:05:59 INFO - PROCESS | 30204 | RSS: Main: 153276416 20:05:59 INFO - PROCESS | 30204 | 20:09:01 INFO - PROCESS | 30204 | Cycle 1(1): loaded http://localhost:47649/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47649/tests/dromaeo/cssquery-mootools.html) 20:09:01 INFO - PROCESS | 30204 | RSS: Main: 153047040 20:09:01 INFO - PROCESS | 30204 | 20:12:03 INFO - PROCESS | 30204 | Cycle 1(1): loaded http://localhost:47649/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47649/tests/dromaeo/cssquery-prototype.html) 20:12:04 INFO - PROCESS | 30204 | RSS: Main: 152219648 20:12:04 INFO - PROCESS | 30204 | 20:15:06 INFO - PROCESS | 30204 | Cycle 1(1): loaded http://localhost:47649/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47649/tests/dromaeo/cssquery-yui.html) 20:15:07 INFO - PROCESS | 30204 | RSS: Main: 153575424 20:15:07 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | Cycle 1(1): loaded http://localhost:47649/tests/dromaeo/cssquery-yui.html (next: http://localhost:47649/tests/dromaeo/cssquery-dojo.html) 20:18:09 INFO - PROCESS | 30204 | RSS: Main: 154902528 20:18:09 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | __start_tp_report 20:18:09 INFO - PROCESS | 30204 | _x_x_mozilla_page_load 20:18:09 INFO - PROCESS | 30204 | _x_x_mozilla_page_load_details 20:18:09 INFO - PROCESS | 30204 | |i|pagename|runs| 20:18:09 INFO - PROCESS | 30204 | |0;dojo.html;3140.5603215549827;3193.5050067239586;3202.455582550966;3226.9515957260633;3243.902682919512;5155.690658560479;5178.223266510021;5226.8693282667955;5233.685978841268;5270.631055826084;5101.081805275049;5186.0665080285535;5215.843524694255;5223;5291.1798671205925;4482.820687172525;4742.264948932912;4915.188993816016;4921.753912304388;4962.181240095398;4721.69308994916;4792.185328494147;4820.276958456242;4867.902641947159;4879.438864530571;4755.809767609291;4807.78364973577;4869.805207791684;4875.658703890729;4886.584640305578;4803.639727020487;4809.78355973982;4810.158222311116;4850.417949846006;4858.489858564871;4738.47876733559;4819.373481447425;4824.782884770194;4840.564349208553;4858.368412106439;5068.239764035424;5074.213496907985;5092.490750924915;5160.793568257265;5166.509181627739;5619.213310136584;5626.071698169797;5632.549396048347;5636.49271565557;5639.774409023634;5635.21107045014;5656.349519805234;5658;5667.546596272288;5684.403137670526;5195.454477279869;5250.3962044364625;5299.258103865462;5330.280412144389;5384.165454354581;5718.428157184248;5737.053386191315;5737.971310143506;5741.712914354265;5747.971260143672;5414.35027796667;5532.6680399176175;5535.059039963216;5538.667679939216;5540.63985840919;5654.604177707521;5680.5171560417;5748.367679555246;5755.62588431759;5816.825495235065;5544.528715059185;5585.636933599384;5589.161625756088;5592.217089607459;5596.860078497989;5506.394296627368;5577.637453565505;5579.051561234519;5594.244776955059;5623.775048998076;4318;4358.302671572533;4358.607725304738;4387.166438376698;4389.62688171509;3924.7645141291614;3973.5430425501436;3974.940375894364;3991.560928297885;4022.879313620596;5196.298499702568;5260.158374660036;5302.761375738101;5367.194920761839;5382.542483888913;5676.517496012885;5695.7152142392715;5752.511036561856;5754.165645981309;5763.991301522216;5329.573634109262;5345.064613692588;5357.142857142839;5372.301600791872;5382.381026181961;4697.154512187771;4790.377250957354;4802.639802014863;4871.025794841046;4895.534924182197;5822.912656310244;5839.240898683144;5839.737211825478;5846.152307915413;5863.912041319383;5606.439356064361;5617.466340697627;5631.971840140937;5650.63270887391;5652.293463317085;5629.099344104923;5754.338251101177;5859.560532959959;5959.612625179349;6012.368701286302;5550.222968784293;5552.7223638818705;5555.3333599966645;5556.749946252347;5557.472040156179;5640.041192997118;5663.688497132533;5664.26364572603;5664.716764161858;5668.234788303691;5456.508914197741;5532.86167845791;5571.997040532743;5594.4125866785025;5667.149927510906;5481.588880833874;5497.697626630414;5505.229267902417;5547.140193270049;5568.16477528374;5322.840314790563;5393.514583687487;5437.619366644297;5452.345718513804;5489.149181876815;5480.150576660624;5530.198121272473;5591.916121258103;5598.636088654224;5652.971735141298;5404.108322126962;5423.83728488146;5432.728363581726;5436.0758671026815;5455.318085239345 20:18:09 INFO - PROCESS | 30204 | |1;ext.html;540.6837000354792;567.7870798450579;598.7096258314717;605.0923614578131;632.3897438971397;34370.48444273338;35382.8155466008;35449.291014179704;35512.28975420493;35519.999999999935;37851;38456.88487133206;38467.23065538694;38806.61193388065;38892.80553597235;8435.156484351563;8634.870476942819;8672.52301123438;8673.219410253076;8693.304535637166;8374.665013399486;8461.661533538681;8496.150384961516;8518.190771876662;8564.272036876873;8434.114417986084;8522.488650680947;8550.144985501462;8577.185167409118;8588.312934965188;8375.62309696062;8518.616662250213;8543.316534677242;8551.444156129832;8555.443896146793;8395.874061889077;8499.405041647087;8499.702510412106;8503.064662887078;8510.829783404297;32409.837950810095;32485.350292994008;32859;32914.50628240578;33013.50479742806;3406.9829650851834;3545.8758943436856;3820.560635526894;3859.671927886133;4049.1901619675887;28161.310321380577;28405.14784556446;28500.572491412644;28581.714182858323;28782.856085719646;3837.0599203195115;3851.441540976543;3912.3349030664854;4028.8992775180564;4066.207089617526;260153;261330;263198;263471;264173.9999999981;53748.46251537435;55862.72068639631;56682.43317566854;56717.43282567204;56901.430985689614;47915.281270780964;64039.679801600694;65948.34051659518;66049.33950660528;66055;15761.133137677309;15991;16047.876648634718;16054.518364449084;16113.597160071093;12136.939315303367;12266.938665306616;12327.890489855956;12331.445084971198;12353.814692779615;19182.328618498286;19190.520236993907;19218.903905480383;19524.316648917218;19897.403077907686;7735.7679269622;7905.169957154531;8014.479058861155;8021.518708877369;8023.558704271204;901.8827552418144;985.3742873275521;1004.7588578741049;1073.6295977887617;1098.6923661374667;28755.28111797222;28817.279568010967;28997.855010724812;29186.416271674447;29246;974.3958745577787;1040.8490768838476;1043.7338478687886;1087.7552550676035;1146.2606618731038;14119.294035298399;15317.923410382877;15840.60398490047;15883.682326353408;16110.597235068983;332564;338695;339482;339489;339614;50357.244641330406;50515;51238.48761512337;51240.23139652908;51245.74377128165;1324.892832220129;1327.87385198406;1335.4324412124809;1335.4991878045732;1343.2947702456092;28069.298267543476;29065.854670726512;29126;29357.7064229355;29366.853165734035;44345.33481997837;44648.33027504525;44685;44777;44802.10395792131;311381;314572;315147;315626;316768.2423818269;30865.69134308628;31509.684903150675;32255.516167257978;32333.838330809136;32337.676623233467;40846.387304191056;41300.793496032325;41902.37146442745;42308.57691423046;42661.57338426576;34896.30207395787;35015.82492087523;35069.82465087761;35114.297714046086;35546.46680299849;35163.47254791129;35318.64681353256;35648.28703425969;35703.46444803382;35916;34749.1312717174;34957.82521087378;34961.65038349584;36173;37002.814985924895;29103.563446547894;31659.366812663156;31771.20571985719;32114.839425803657;32439.351212976082;24206.15278465245;24451;24466.266012019667;24898.253052408458;24991.87504062468 20:18:09 INFO - PROCESS | 30204 | |2;jquery.html;358.37105879182036;360.4575114452748;363.8090002748558;364.0353064379394;365.6234078898734;15823.683526329467;16612.584685382855;16843.91578042111;17486.475405737816;17618.91190544047;10345.948270258637;10505.581746464226;16357.427490037851;16761.161941902916;16789.832101678978;4552.226121559334;5377.623566350357;5420.783168673268;5423.918641220384;5429.077056900317;5008.874778130539;5190.870228244286;5263.789448422059;5324.1747529133045;5328.706921119337;5308.044551980642;5311.760970756306;5336.759845806929;5337.412884582693;5347.679139251638;5063.569596584295;5280.155175171954;5322.4411436799155;5330.093884039684;5353.544948679367;4777.5222477752295;4780.689255198401;4811.4707382187935;4812.7352995585225;4826.638002149853;17998.1000949952;18655.720164197548;18925.33761318361;19612.411627651192;20354.982250887395;2048.5185981294385;2083.114676262582;2125.5855108253895;2182.890855457221;2212.513247085639;9033.548322583845;9399.295052871063;12007.159498835084;12783.701201907641;13063.738725225443;1841.686913224755;1852.8239817217343;1855.6010457751513;1876.690346092893;1939.5442071113278;50960.49039509631;51056;53852;55527.72236138793;56376.15435768467;9344.813103737888;9555.90444095564;9702.951485242529;9709.563069661883;9733.805323893483;12162.08784341178;12415.689607759698;12686.11197216186;13389.129706569041;13437.395317210554;7577.16651168371;7822.1004584472375;7895.60521973899;7916.643751031217;7935.841283174304;7172.0676312079095;7364.77905662831;7377.299156580117;7496.400287977058;7658.65536050879;4391.407160033355;4426.9778651106535;4494.70784399013;4525.637948964075;4545.545445455428;1847.3995951315876;1891.6500447417272;1909.8281154696144;1931.2950772968047;1950.2686492565288;418.9601987811214;905.3707673167218;911.3119594706087;965.6958058211641;988.2439933450916;9984.201263899016;10346.22403319754;10478.63324783629;15622.921885390728;16209.270582823801;892.9241014513709;933.1927882381691;990.1039559198937;993.8012397520525;1042.4162469017224;7740.4194685398825;8894.110588941054;9114;9128.40665356763;9936.20510359184;348313;356921;357120;359470;489009;61242;72086.63956680182;73365;75375;77025.6148719264;1166.1137535472933;1200.11911852292;1204.9638510844688;1206.1315852586124;1208.1301462946665;14261.144331340152;14335.498257560936;14825.851741482447;14864.925675371554;14959.551213463614;26618.467630647665;27285.317867053483;31538.526922096647;31736.523952140273;32651;41524.169516610105;43636.34545481884;44547.554524455634;44588.55411445974;49550.50449495459;9374.812503750023;9658.179054780423;9663.565139568876;10017.39895606266;10130.138938190335;11352.94323528377;11535.134864885335;11821;12063.81904271419;12139.696507587381;6698.56459330142;6837.35045170708;7148.320909513588;7196.712131514891;7244.166920804175;7017.649117544204;7194.964025179841;7503.09962804467;7508.849823003618;7537.623118844145;7315.48791584584;7355.852882942204;7408.740694075897;7442.516236444614;7486.064241969754;9813.411195328017;9968.850467243143;10145.746356341151;10175.84736228972;10384.844227336445;10295.176385889261;10386.169106471312;10498.212634052325;10508.947455262674;10580.259381843505 20:18:09 INFO - PROCESS | 30204 | |3;mootools.html;1443.5308524729464;1478.231319713749;1642.6057746140923;1766.3199668127768;1791.0954967741288;7048.506604537684;7166.283371662831;7234.421246300297;7287.562746235223;7335.7432489862795;7326.926730732691;7352.705891764336;7367.079115110611;7419.517731347459;7445.702171913131;2266.829987750917;2284.931452056441;2285.451491642002;2286.314105768271;2292.6790249365104;2302.700648915639;2333.7199536055696;2334.9066037358484;2343.789058984691;2344.542814151241;2030.4111807575784;2064.2465500092435;2201.570693714726;2297.8161747060194;2310.803581695558;2238.764929682376;2239.29462219402;2242.7869352411494;2243.371855880356;2246.550689862026;2132.0938601094626;2165.935021949344;2167.1873047607146;2179.095675294751;2181.5418762059985;7126.64366781664;7160.319769621878;7184.928150718478;7197.568145911262;7207;4578.35902973584;4690.624750019991;4736;4751.073540659573;4774.16452120881;3029.4546981543313;3040.1183656739518;3086.6450358208867;3095.628524577065;3140.262038420969;999.7400675824338;1007.2948935745007;1022.6983040003142;1040.547361897577;1078.5577913055688;9847.655332063416;9926.851097233548;9946.502674866228;9976.750581235454;9977.451240181786;4177.101923086551;4195.370694395865;4214.093969796509;4237.449131612932;4279.679024073144;8227.341812654973;8266.090730019692;8282.088970213272;8294.34113177367;8298.087210406971;4696.929546056812;4697.154512187771;4705.670603057822;4714.882127946828;4742.051589682077;4350.60844523988;4357.934630980538;4361.062371590124;4375;4384.05742765307;3403.1151900506047;3421.469672200813;3432.7768695034742;3442.8106454145263;3463.8441270142903;1091.812897537935;1111.4498323330004;1114.3146964616703;1119.3451830679144;1125.887411258884;1040.490159821682;1042.3276986343765;1096.4156793433413;1211.878812118781;1298.9610311690665;6868.553544019623;6874.725010999604;6903.6548172591165;6919.481038922101;6944.930550694529;1078.2075174746556;1110.4225802582612;1111.2554588425774;1124.4714983957526;1127.9154063445274;5403.297571315704;5407.215953686693;5445.319335083114;5449.6730196188355;5452.618316717871;8299.6680132794;8404.327653787805;8476.321894248445;8585.570721463902;8829;8185.222403871623;8228.62971166299;8237.752867413867;8242.958785206036;8393.748187554384;6720.092787473628;6802.081718967876;6867.484938629723;6880.552764070319;6908.549204666976;6785.694643740945;6820.658967051727;6824.590524568542;6832.350926661959;6837.803384407609;7606.733764318223;7742.032245969254;7944.245296696805;7957.482763620346;8023;8027.2775450209765;8146.185381461806;8247.793805154919;8283.17168283167;8327.417080804285;6532.5753826001155;6548.967255163694;6601.174853143357;6611.636360000246;6621.702023409054;7036.753713619999;7130.393916516947;7132.465065120033;7138.535995160298;7158.961950517041;6563.573367731082;6600.20523396169;6725.630090345078;6852.903097301026;6890.1731792183255;6582.80251592453;6672.4328432081875;6700.631465269457;6705.765298214539;6762.459003279628;6603.009548567561;6616.4045235929;6646.734130634721;6658.700358483783;6662.966685166737;6106.114613380946;6166.660833654192;6257.7184026719815;6285.402886725754;6296.842578935563;6116.541259405473;6122.204113465221;6142.04798256271;6160.568760186744;6166.445019948047 20:18:09 INFO - PROCESS | 30204 | |4;prototype.html;327.3469428490163;334.7338865601846;344.4798354484727;348.58344278587066;351.93137338219043;6247.6251424914535;6250.5312101592335;6335.683215839207;6355.872882542347;6448.838779030527;6257.561970662044;6300.401461861127;6318.557700960934;6318.905216421757;6327.905081423783;4808.158572249859;4815.735134567597;4820.734859582739;4824.228123500241;4824.4934281900505;4791.760411979404;4804.279358096296;4825.276208568725;4825.879353016167;4828.082664293791;4675.462321832999;4781.521847815208;4793.976030119845;4801.567858892699;4804.639652026094;4765.189917713979;4784.99515101829;4787.066522028206;4787.6648634595595;4798.856034318976;4172.853950111731;4174.060836311836;4183.602557757039;4185.644220241283;4188.350805625133;6029.969850150765;6030.608010479349;6034.004389275764;6035.426634469718;6040.335563088057;5471.425500322449;5593.496585307342;5594.748236329375;5598.1602759585985;5607.663540187602;6698.8995165072565;6702.229243636995;6704.5306828522025;6710.966445167792;6726.966365168192;4603;4613.5847773700525;4616.884577885579;4620.3762492063815;4624.606908412789;6721.0926524919;6889.104416425833;6960.234374218832;6966.5471744336455;7027.543209691354;4616.6537509686905;4631.560001799824;4633.49031606523;4640.744759038285;4642.767861606906;4696.694714843524;4706.717596944126;4706.788194531186;4713.269443236304;4722.315264286659;5480.123180291134;5481.424450432647;5482.5613950883835;5488.039593071197;5491.313585801775;6545.869082618321;6671.39957403836;6676.599404035774;6699.76550820719;6704.4301234395625;1644.925978330978;1660.1616183827332;1684.6546457976085;1687.5527985083963;1688.282479946018;1118.9216754827085;1132.6998345438465;1132.7734453109247;1134.4554613785429;1142.731458107344;6290.748370065237;6298.338674439118;6302.432781049728;6309.905351419732;6312.684365781693;6768.221654509696;6776.017477465838;6809.489288303397;6812.62530560814;6829.658517074126;6119.082137679384;6188.009918413032;6282.371762823773;6291.811245662546;6308.211473565804;3678.2275722098125;3690.907727306785;3693.0582701410967;3697.3159965406485;3704.4258139988347;7074.469414793808;7096.929030709627;7145.249748776408;7148.463865210026;7156.785296441115;6819.454443644497;6976.860462790716;6981.2669669684965;6988.056612357368;7000.439964802804;7186;7204.135503739585;7211.747588834365;7219.3502584766575;7284.854302914018;6846.931530684629;6850.246472887879;6862.245153033262;6894.207166175954;6933.687984040629;6630.9668451657435;6826.351496608013;6827.21487028998;6836.726530938707;6855.657217139223;7282.12614486265;7282.417406607353;7289.708411663474;7294.1247050354295;7306.744263950736;4704.29435584665;4734.502877197845;4737.66836321468;4744.240921452689;4745.786439610157;6708.758879607289;6876.037354770237;6909.965450172918;6925.792226233221;6935.514513983972;6659.433948114464;6715.328467153246;6723.899141512979;6724.798256052326;6731.091302674076;6681.5656982296;6701.262861085374;6701.899471507833;6717.630530320879;6727.293634168342;6446.452051575481;6544.6727663617585;6558.557117434157;6560.376764207393;6563.04835798816;6689.76585819494;6722.932770672231;6732;6735.191776986793;6735.595864248161;6504.252011018793;6527;6563.704633291609;6590.7693230736695;6601.933980660324 20:18:09 INFO - PROCESS | 30204 | |5;yui.html;724.4892350892621;777.8249893773901;798.2217338095354;843.5444859775723;852.8422241885252;13006.219626822385;13104.14823036502;13127.08110432269;13133.080684352075;13235.205887646736;12975.545855895045;13029.21824690517;13036.348182590857;13044.673883152926;13048.673783155426;658.6081281637418;663.9136912201407;774.7404619452476;790.2492631999595;792.7027364738224;803.586153131138;806.0649646410166;807.5719868469721;808.0343988933228;812.2324403438753;841.238678995507;841.5960339037266;843.1315744782884;846.7798372423152;846.8772028055928;841.6128580852815;841.8400503904238;844.932405407566;845.7631863078348;846.090452763282;620.8944479438507;621.8103478439074;623.6320570863212;623.6850390552787;628.5568674084805;13456.058075934689;13470.663233419145;13495.392707328096;13499.797503037462;13511;12815.359232038454;13090.410931508104;13215.074944753775;13258.270795106266;13338.533151339656;10177.287589868713;10284.588616455332;10482.213833962483;10645.323058742924;10808.783824323547;3631.6005239423644;3669.101070237809;3680.6319368063246;3712.9071773205615;3777.1690228149764;42833;42876.35685464721;42884.356734649;43363.56636433627;43543;9851.704448866545;10267.229957753198;10272.135299807565;10347.94826025865;10696.090832279187;18433.170507327202;18437.815621843878;18494.075296235136;18504.81495185031;18516.16677249527;7238.782836514913;7500.812479687942;7836.216378362118;8011.599420028975;8058.073321568095;4431.8448854289945;4444.2444784386735;4460;4487.349334346567;4551.431071116111;3023.0779612218485;3049.207206126423;3051.5422686596744;3053.0535533984535;3055.2667359833927;554.3901708121034;573.5039191099752;574.0499473371576;575.1516513143081;579.2672269578986;572.5076434266527;599.6132494540997;624.3756243756244;631.2614241337554;651.9380658837403;8468.195521425454;9424.528773561295;9448.763780905394;9467.431954082776;9496.47769372691;513.2352794336412;516.839779668304;534.7513406266105;543.7933585237663;546.9097598896217;3581.83881725323;3925.2542017017245;3956.129651476728;3990.780507072139;4041.939370909439;54577.45422545803;54704.45295547073;54908.725456372464;55033.449665503635;55130.72434637801;49046;55563.72218138883;55884;56693.43306566882;57112;42897.785511072245;44141;44807.55192448099;45087.872803179525;45243;8184.672613095409;8323.750287491384;8685.218330350299;8780.956095219482;8791.824163516821;33702.32595348128;33952;34508.65491345055;34603.65396346105;34654.133646658025;39362.21275574415;40577.79711101425;42984.78507607442;43164.568354316056;43243;10605.310654807412;10827.783444331228;10845.837312440477;11009.61466348674;11070.225084244348;12003.1597788154;12129.939350303192;12161.270323780602;12205.69485762863;12591.685207869876;10750.838737418788;10988;11031.669049928514;11378.829317560409;11627.418629068681;11141.888581114084;11377.374244416636;11521.88478115208;11774.80535036913;11990.100742444178;10473.266871318934;10547.156227501935;10605.787884242427;10663.360198388122;10715.571377144826;8559.443636163629;8727.476351418934;8826.646934122564;9131.863022054542;9172.495512746864;8860.424072435271;9075.27397808187;9363.953180234055;9553.713388598353;9646.662366817127 20:18:09 INFO - PROCESS | 30204 | __end_tp_report 20:18:09 INFO - PROCESS | 30204 | __start_cc_report 20:18:09 INFO - PROCESS | 30204 | _x_x_mozilla_cycle_collect,312 20:18:09 INFO - PROCESS | 30204 | __end_cc_report 20:18:09 INFO - PROCESS | 30204 | __startTimestamp1452485889727__endTimestamp 20:18:09 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | ------- Summary: start ------- 20:18:09 INFO - PROCESS | 30204 | Number of tests: 6 20:18:09 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | [#0] dojo.html Cycles:165 Average:5246.36 Median:5437.62 stddev:568.58 (10.5%) stddev-sans-first:545.80 20:18:09 INFO - PROCESS | 30204 | Values: 3140.6 3193.5 3202.5 3227.0 3243.9 5155.7 5178.2 5226.9 5233.7 5270.6 5101.1 5186.1 5215.8 5223.0 5291.2 4482.8 4742.3 4915.2 4921.8 4962.2 4721.7 4792.2 4820.3 4867.9 4879.4 4755.8 4807.8 4869.8 4875.7 4886.6 4803.6 4809.8 4810.2 4850.4 4858.5 4738.5 4819.4 4824.8 4840.6 4858.4 5068.2 5074.2 5092.5 5160.8 5166.5 5619.2 5626.1 5632.5 5636.5 5639.8 5635.2 5656.3 5658.0 5667.5 5684.4 5195.5 5250.4 5299.3 5330.3 5384.2 5718.4 5737.1 5738.0 5741.7 5748.0 5414.4 5532.7 5535.1 5538.7 5540.6 5654.6 5680.5 5748.4 5755.6 5816.8 5544.5 5585.6 5589.2 5592.2 5596.9 5506.4 5577.6 5579.1 5594.2 5623.8 4318.0 4358.3 4358.6 4387.2 4389.6 3924.8 3973.5 3974.9 3991.6 4022.9 5196.3 5260.2 5302.8 5367.2 5382.5 5676.5 5695.7 5752.5 5754.2 5764.0 5329.6 5345.1 5357.1 5372.3 5382.4 4697.2 4790.4 4802.6 4871.0 4895.5 5822.9 5839.2 5839.7 5846.2 5863.9 5606.4 5617.5 5632.0 5650.6 5652.3 5629.1 5754.3 5859.6 5959.6 6012.4 5550.2 5552.7 5555.3 5556.7 5557.5 5640.0 5663.7 5664.3 5664.7 5668.2 5456.5 5532.9 5572.0 5594.4 5667.1 5481.6 5497.7 5505.2 5547.1 5568.2 5322.8 5393.5 5437.6 5452.3 5489.1 5480.2 5530.2 5591.9 5598.6 5653.0 5404.1 5423.8 5432.7 5436.1 5455.3 20:18:09 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | [#1] ext.html Cycles:180 Average:46748.78 Median:35138.89 stddev:80326.43 (228.6%) stddev-sans-first:80476.84 20:18:09 INFO - PROCESS | 30204 | Values: 540.7 567.8 598.7 605.1 632.4 34370.5 35382.8 35449.3 35512.3 35520.0 37851.0 38456.9 38467.2 38806.6 38892.8 8435.2 8634.9 8672.5 8673.2 8693.3 8374.7 8461.7 8496.2 8518.2 8564.3 8434.1 8522.5 8550.1 8577.2 8588.3 8375.6 8518.6 8543.3 8551.4 8555.4 8395.9 8499.4 8499.7 8503.1 8510.8 32409.8 32485.4 32859.0 32914.5 33013.5 3407.0 3545.9 3820.6 3859.7 4049.2 28161.3 28405.1 28500.6 28581.7 28782.9 3837.1 3851.4 3912.3 4028.9 4066.2 260153.0 261330.0 263198.0 263471.0 264174.0 53748.5 55862.7 56682.4 56717.4 56901.4 47915.3 64039.7 65948.3 66049.3 66055.0 15761.1 15991.0 16047.9 16054.5 16113.6 12136.9 12266.9 12327.9 12331.4 12353.8 19182.3 19190.5 19218.9 19524.3 19897.4 7735.8 7905.2 8014.5 8021.5 8023.6 901.9 985.4 1004.8 1073.6 1098.7 28755.3 28817.3 28997.9 29186.4 29246.0 974.4 1040.8 1043.7 1087.8 1146.3 14119.3 15317.9 15840.6 15883.7 16110.6 332564.0 338695.0 339482.0 339489.0 339614.0 50357.2 50515.0 51238.5 51240.2 51245.7 1324.9 1327.9 1335.4 1335.5 1343.3 28069.3 29065.9 29126.0 29357.7 29366.9 44345.3 44648.3 44685.0 44777.0 44802.1 311381.0 314572.0 315147.0 315626.0 316768.2 30865.7 31509.7 32255.5 32333.8 32337.7 40846.4 41300.8 41902.4 42308.6 42661.6 34896.3 35015.8 35069.8 35114.3 35546.5 35163.5 35318.6 35648.3 35703.5 35916.0 34749.1 34957.8 34961.7 36173.0 37002.8 29103.6 31659.4 31771.2 32114.8 32439.4 24206.2 24451.0 24466.3 24898.3 24991.9 20:18:09 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | [#2] jquery.html Cycles:180 Average:22805.09 Median:4535.59 stddev:63371.53 (1397.2%) stddev-sans-first:63526.89 20:18:09 INFO - PROCESS | 30204 | Values: 358.4 360.5 363.8 364.0 365.6 15823.7 16612.6 16843.9 17486.5 17618.9 10345.9 10505.6 16357.4 16761.2 16789.8 4552.2 5377.6 5420.8 5423.9 5429.1 5008.9 5190.9 5263.8 5324.2 5328.7 5308.0 5311.8 5336.8 5337.4 5347.7 5063.6 5280.2 5322.4 5330.1 5353.5 4777.5 4780.7 4811.5 4812.7 4826.6 17998.1 18655.7 18925.3 19612.4 20355.0 2048.5 2083.1 2125.6 2182.9 2212.5 9033.5 9399.3 12007.2 12783.7 13063.7 1841.7 1852.8 1855.6 1876.7 1939.5 50960.5 51056.0 53852.0 55527.7 56376.2 9344.8 9555.9 9703.0 9709.6 9733.8 12162.1 12415.7 12686.1 13389.1 13437.4 7577.2 7822.1 7895.6 7916.6 7935.8 7172.1 7364.8 7377.3 7496.4 7658.7 4391.4 4427.0 4494.7 4525.6 4545.5 1847.4 1891.7 1909.8 1931.3 1950.3 419.0 905.4 911.3 965.7 988.2 9984.2 10346.2 10478.6 15622.9 16209.3 892.9 933.2 990.1 993.8 1042.4 7740.4 8894.1 9114.0 9128.4 9936.2 348313.0 356921.0 357120.0 359470.0 489009.0 61242.0 72086.6 73365.0 75375.0 77025.6 1166.1 1200.1 1205.0 1206.1 1208.1 14261.1 14335.5 14825.9 14864.9 14959.6 26618.5 27285.3 31538.5 31736.5 32651.0 41524.2 43636.3 44547.6 44588.6 49550.5 9374.8 9658.2 9663.6 10017.4 10130.1 11352.9 11535.1 11821.0 12063.8 12139.7 6698.6 6837.4 7148.3 7196.7 7244.2 7017.6 7195.0 7503.1 7508.8 7537.6 7315.5 7355.9 7408.7 7442.5 7486.1 9813.4 9968.9 10145.7 10175.8 10384.8 10295.2 10386.2 10498.2 10508.9 10580.3 20:18:09 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | [#3] mootools.html Cycles:180 Average:5184.94 Median:6212.19 stddev:2574.44 (41.4%) stddev-sans-first:2566.30 20:18:09 INFO - PROCESS | 30204 | Values: 1443.5 1478.2 1642.6 1766.3 1791.1 7048.5 7166.3 7234.4 7287.6 7335.7 7326.9 7352.7 7367.1 7419.5 7445.7 2266.8 2284.9 2285.5 2286.3 2292.7 2302.7 2333.7 2334.9 2343.8 2344.5 2030.4 2064.2 2201.6 2297.8 2310.8 2238.8 2239.3 2242.8 2243.4 2246.6 2132.1 2165.9 2167.2 2179.1 2181.5 7126.6 7160.3 7184.9 7197.6 7207.0 4578.4 4690.6 4736.0 4751.1 4774.2 3029.5 3040.1 3086.6 3095.6 3140.3 999.7 1007.3 1022.7 1040.5 1078.6 9847.7 9926.9 9946.5 9976.8 9977.5 4177.1 4195.4 4214.1 4237.4 4279.7 8227.3 8266.1 8282.1 8294.3 8298.1 4696.9 4697.2 4705.7 4714.9 4742.1 4350.6 4357.9 4361.1 4375.0 4384.1 3403.1 3421.5 3432.8 3442.8 3463.8 1091.8 1111.4 1114.3 1119.3 1125.9 1040.5 1042.3 1096.4 1211.9 1299.0 6868.6 6874.7 6903.7 6919.5 6944.9 1078.2 1110.4 1111.3 1124.5 1127.9 5403.3 5407.2 5445.3 5449.7 5452.6 8299.7 8404.3 8476.3 8585.6 8829.0 8185.2 8228.6 8237.8 8243.0 8393.7 6720.1 6802.1 6867.5 6880.6 6908.5 6785.7 6820.7 6824.6 6832.4 6837.8 7606.7 7742.0 7944.2 7957.5 8023.0 8027.3 8146.2 8247.8 8283.2 8327.4 6532.6 6549.0 6601.2 6611.6 6621.7 7036.8 7130.4 7132.5 7138.5 7159.0 6563.6 6600.2 6725.6 6852.9 6890.2 6582.8 6672.4 6700.6 6705.8 6762.5 6603.0 6616.4 6646.7 6658.7 6663.0 6106.1 6166.7 6257.7 6285.4 6296.8 6116.5 6122.2 6142.0 6160.6 6166.4 20:18:09 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | [#4] prototype.html Cycles:180 Average:5572.58 Median:6305.32 stddev:1689.73 (26.8%) stddev-sans-first:1647.96 20:18:09 INFO - PROCESS | 30204 | Values: 327.3 334.7 344.5 348.6 351.9 6247.6 6250.5 6335.7 6355.9 6448.8 6257.6 6300.4 6318.6 6318.9 6327.9 4808.2 4815.7 4820.7 4824.2 4824.5 4791.8 4804.3 4825.3 4825.9 4828.1 4675.5 4781.5 4794.0 4801.6 4804.6 4765.2 4785.0 4787.1 4787.7 4798.9 4172.9 4174.1 4183.6 4185.6 4188.4 6030.0 6030.6 6034.0 6035.4 6040.3 5471.4 5593.5 5594.7 5598.2 5607.7 6698.9 6702.2 6704.5 6711.0 6727.0 4603.0 4613.6 4616.9 4620.4 4624.6 6721.1 6889.1 6960.2 6966.5 7027.5 4616.7 4631.6 4633.5 4640.7 4642.8 4696.7 4706.7 4706.8 4713.3 4722.3 5480.1 5481.4 5482.6 5488.0 5491.3 6545.9 6671.4 6676.6 6699.8 6704.4 1644.9 1660.2 1684.7 1687.6 1688.3 1118.9 1132.7 1132.8 1134.5 1142.7 6290.7 6298.3 6302.4 6309.9 6312.7 6768.2 6776.0 6809.5 6812.6 6829.7 6119.1 6188.0 6282.4 6291.8 6308.2 3678.2 3690.9 3693.1 3697.3 3704.4 7074.5 7096.9 7145.2 7148.5 7156.8 6819.5 6976.9 6981.3 6988.1 7000.4 7186.0 7204.1 7211.7 7219.4 7284.9 6846.9 6850.2 6862.2 6894.2 6933.7 6631.0 6826.4 6827.2 6836.7 6855.7 7282.1 7282.4 7289.7 7294.1 7306.7 4704.3 4734.5 4737.7 4744.2 4745.8 6708.8 6876.0 6910.0 6925.8 6935.5 6659.4 6715.3 6723.9 6724.8 6731.1 6681.6 6701.3 6701.9 6717.6 6727.3 6446.5 6544.7 6558.6 6560.4 6563.0 6689.8 6722.9 6732.0 6735.2 6735.6 6504.3 6527.0 6563.7 6590.8 6601.9 20:18:09 INFO - PROCESS | 30204 | 20:18:09 INFO - PROCESS | 30204 | [#5] yui.html Cycles:180 Average:13529.49 Median:24286.42 stddev:15447.42 (63.6%) stddev-sans-first:15460.82 20:18:09 INFO - PROCESS | 30204 | Values: 724.5 777.8 798.2 843.5 852.8 13006.2 13104.1 13127.1 13133.1 13235.2 12975.5 13029.2 13036.3 13044.7 13048.7 658.6 663.9 774.7 790.2 792.7 803.6 806.1 807.6 808.0 812.2 841.2 841.6 843.1 846.8 846.9 841.6 841.8 844.9 845.8 846.1 620.9 621.8 623.6 623.7 628.6 13456.1 13470.7 13495.4 13499.8 13511.0 12815.4 13090.4 13215.1 13258.3 13338.5 10177.3 10284.6 10482.2 10645.3 10808.8 3631.6 3669.1 3680.6 3712.9 3777.2 42833.0 42876.4 42884.4 43363.6 43543.0 9851.7 10267.2 10272.1 10347.9 10696.1 18433.2 18437.8 18494.1 18504.8 18516.2 7238.8 7500.8 7836.2 8011.6 8058.1 4431.8 4444.2 4460.0 4487.3 4551.4 3023.1 3049.2 3051.5 3053.1 3055.3 554.4 573.5 574.0 575.2 579.3 572.5 599.6 624.4 631.3 651.9 8468.2 9424.5 9448.8 9467.4 9496.5 513.2 516.8 534.8 543.8 546.9 3581.8 3925.3 3956.1 3990.8 4041.9 54577.5 54704.5 54908.7 55033.4 55130.7 49046.0 55563.7 55884.0 56693.4 57112.0 42897.8 44141.0 44807.6 45087.9 45243.0 8184.7 8323.8 8685.2 8781.0 8791.8 33702.3 33952.0 34508.7 34603.7 34654.1 39362.2 40577.8 42984.8 43164.6 43243.0 10605.3 10827.8 10845.8 11009.6 11070.2 12003.2 12129.9 12161.3 12205.7 12591.7 10750.8 10988.0 11031.7 11378.8 11627.4 11141.9 11377.4 11521.9 11774.8 11990.1 10473.3 10547.2 10605.8 10663.4 10715.6 8559.4 8727.5 8826.6 9131.9 9172.5 8860.4 9075.3 9364.0 9553.7 9646.7 20:18:09 INFO - PROCESS | 30204 | -------- Summary: end -------- 20:18:09 INFO - PROCESS | 30204 | 20:18:10 INFO - TEST-INFO | 30204: exit 0 20:18:10 INFO - TEST-OK | dromaeo_css | took 1111181ms 20:18:10 INFO - TEST-START | kraken 20:18:10 INFO - operating with platform_type : linux_ 20:18:10 INFO - Initialising browser for kraken test... 20:18:10 INFO - TEST-INFO | started process 30449 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDSgrKg/profile http://localhost:47649/getInfo.html) 20:18:14 INFO - PROCESS | 30449 | 20:18:14 INFO - PROCESS | 30449 | (process:30521): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:18:15 INFO - PROCESS | 30449 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:18:15 INFO - PROCESS | 30449 | __metrics Screen width/height:1600/1200 20:18:15 INFO - PROCESS | 30449 | colorDepth:24 20:18:15 INFO - PROCESS | 30449 | Browser inner width/height: 1024/697 20:18:15 INFO - PROCESS | 30449 | __metrics 20:18:15 INFO - PROCESS | 30449 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:18:16 INFO - TEST-INFO | 30449: exit 0 20:18:16 INFO - Browser initialized. 20:18:16 INFO - Running cycle 1/1 for kraken test... 20:18:16 INFO - TEST-INFO | started process 30570 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDSgrKg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:18 INFO - PROCESS | 30570 | 20:18:18 INFO - PROCESS | 30570 | (process:30630): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:18:28 INFO - PROCESS | 30570 | RSS: Main: 150884352 20:18:28 INFO - PROCESS | 30570 | 20:18:31 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47649/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:31 INFO - PROCESS | 30570 | RSS: Main: 152498176 20:18:31 INFO - PROCESS | 30570 | 20:18:34 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47649/tests/kraken/driver.html?testName=audio-dft) 20:18:35 INFO - PROCESS | 30570 | RSS: Main: 151003136 20:18:35 INFO - PROCESS | 30570 | 20:18:37 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47649/tests/kraken/driver.html?testName=audio-fft) 20:18:38 INFO - PROCESS | 30570 | RSS: Main: 146898944 20:18:38 INFO - PROCESS | 30570 | 20:18:40 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47649/tests/kraken/driver.html?testName=audio-oscillator) 20:18:41 INFO - PROCESS | 30570 | RSS: Main: 147058688 20:18:41 INFO - PROCESS | 30570 | 20:18:43 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47649/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:44 INFO - PROCESS | 30570 | RSS: Main: 147865600 20:18:44 INFO - PROCESS | 30570 | 20:18:47 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47649/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:47 INFO - PROCESS | 30570 | RSS: Main: 147394560 20:18:47 INFO - PROCESS | 30570 | 20:18:51 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47649/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:51 INFO - PROCESS | 30570 | RSS: Main: 149073920 20:18:51 INFO - PROCESS | 30570 | 20:18:54 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47649/tests/kraken/driver.html?testName=json-parse-financial) 20:18:55 INFO - PROCESS | 30570 | RSS: Main: 149536768 20:18:55 INFO - PROCESS | 30570 | 20:18:56 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47649/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:57 INFO - PROCESS | 30570 | RSS: Main: 149598208 20:18:57 INFO - PROCESS | 30570 | 20:18:59 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47649/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:59 INFO - PROCESS | 30570 | RSS: Main: 149151744 20:18:59 INFO - PROCESS | 30570 | 20:19:01 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47649/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:02 INFO - PROCESS | 30570 | RSS: Main: 149663744 20:19:02 INFO - PROCESS | 30570 | 20:19:04 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:05 INFO - PROCESS | 30570 | RSS: Main: 149565440 20:19:05 INFO - PROCESS | 30570 | 20:19:08 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:08 INFO - PROCESS | 30570 | RSS: Main: 148770816 20:19:08 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | Cycle 1(1): loaded http://localhost:47649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47649/tests/kraken/driver.html?testName=ai-astar) 20:19:10 INFO - PROCESS | 30570 | RSS: Main: 148901888 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | __start_tp_report 20:19:10 INFO - PROCESS | 30570 | _x_x_mozilla_page_load 20:19:10 INFO - PROCESS | 30570 | _x_x_mozilla_page_load_details 20:19:10 INFO - PROCESS | 30570 | |i|pagename|runs| 20:19:10 INFO - PROCESS | 30570 | |0;ai-astar;112;106;114;111;113;123;112;114;112;113 20:19:10 INFO - PROCESS | 30570 | |1;audio-beat-detection;151;124;149;162;128;156;156;131;168;130 20:19:10 INFO - PROCESS | 30570 | |2;audio-dft;164;163;163;164;161;162;161;162;178;162 20:19:10 INFO - PROCESS | 30570 | |3;audio-fft;75;74;75;75;72;146;73;74;74;74 20:19:10 INFO - PROCESS | 30570 | |4;audio-oscillator;96;96;142;97;96;96;150;95;97;133 20:19:10 INFO - PROCESS | 30570 | |5;imaging-gaussian-blur;111;110;110;110;110;110;111;110;109;110 20:19:10 INFO - PROCESS | 30570 | |6;imaging-darkroom;147;148;147;148;147;146;147;147;148;147 20:19:10 INFO - PROCESS | 30570 | |7;imaging-desaturate;96;98;96;98;95;96;97;96;96;96 20:19:10 INFO - PROCESS | 30570 | |8;json-parse-financial;58;57;60;58;59;60;59;63;55;55 20:19:10 INFO - PROCESS | 30570 | |9;json-stringify-tinderbox;67;67;68;67;67;67;67;68;67;67 20:19:10 INFO - PROCESS | 30570 | |10;stanford-crypto-aes;84;86;87;85;86;86;87;88;99;86 20:19:10 INFO - PROCESS | 30570 | |11;stanford-crypto-ccm;126;127;116;127;121;119;128;126;117;124 20:19:10 INFO - PROCESS | 30570 | |12;stanford-crypto-pbkdf2;142;152;154;151;154;145;152;148;155;142 20:19:10 INFO - PROCESS | 30570 | |13;stanford-crypto-sha256-iterative;73;70;67;71;68;73;73;70;70;69 20:19:10 INFO - PROCESS | 30570 | __end_tp_report 20:19:10 INFO - PROCESS | 30570 | __start_cc_report 20:19:10 INFO - PROCESS | 30570 | _x_x_mozilla_cycle_collect,736 20:19:10 INFO - PROCESS | 30570 | __end_cc_report 20:19:10 INFO - PROCESS | 30570 | __startTimestamp1452485950615__endTimestamp 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | ------- Summary: start ------- 20:19:10 INFO - PROCESS | 30570 | Number of tests: 14 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:4.19 (3.7%) stddev-sans-first:4.43 20:19:10 INFO - PROCESS | 30570 | Values: 112.0 106.0 114.0 111.0 113.0 123.0 112.0 114.0 112.0 113.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:153.50 stddev:15.85 (10.3%) stddev-sans-first:16.68 20:19:10 INFO - PROCESS | 30570 | Values: 151.0 124.0 149.0 162.0 128.0 156.0 156.0 131.0 168.0 130.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:5.03 (3.1%) stddev-sans-first:5.34 20:19:10 INFO - PROCESS | 30570 | Values: 164.0 163.0 163.0 164.0 161.0 162.0 161.0 162.0 178.0 162.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#3] audio-fft Cycles:10 Average:81.20 Median:74.00 stddev:22.79 (30.8%) stddev-sans-first:24.06 20:19:10 INFO - PROCESS | 30570 | Values: 75.0 74.0 75.0 75.0 72.0 146.0 73.0 74.0 74.0 74.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:22.36 (23.3%) stddev-sans-first:23.15 20:19:10 INFO - PROCESS | 30570 | Values: 96.0 96.0 142.0 97.0 96.0 96.0 150.0 95.0 97.0 133.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 20:19:10 INFO - PROCESS | 30570 | Values: 111.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 110.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:19:10 INFO - PROCESS | 30570 | Values: 147.0 148.0 147.0 148.0 147.0 146.0 147.0 147.0 148.0 147.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 20:19:10 INFO - PROCESS | 30570 | Values: 96.0 98.0 96.0 98.0 95.0 96.0 97.0 96.0 96.0 96.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:2.41 (4.1%) stddev-sans-first:2.55 20:19:10 INFO - PROCESS | 30570 | Values: 58.0 57.0 60.0 58.0 59.0 60.0 59.0 63.0 55.0 55.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 20:19:10 INFO - PROCESS | 30570 | Values: 67.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 67.0 67.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.50 stddev:4.22 (4.9%) stddev-sans-first:4.29 20:19:10 INFO - PROCESS | 30570 | Values: 84.0 86.0 87.0 85.0 86.0 86.0 87.0 88.0 99.0 86.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:126.00 stddev:4.48 (3.6%) stddev-sans-first:4.63 20:19:10 INFO - PROCESS | 30570 | Values: 126.0 127.0 116.0 127.0 121.0 119.0 128.0 126.0 117.0 124.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:152.00 stddev:4.95 (3.3%) stddev-sans-first:4.44 20:19:10 INFO - PROCESS | 30570 | Values: 142.0 152.0 154.0 151.0 154.0 145.0 152.0 148.0 155.0 142.0 20:19:10 INFO - PROCESS | 30570 | 20:19:10 INFO - PROCESS | 30570 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.12 (3.0%) stddev-sans-first:2.03 20:19:10 INFO - PROCESS | 30570 | Values: 73.0 70.0 67.0 71.0 68.0 73.0 73.0 70.0 70.0 69.0 20:19:10 INFO - PROCESS | 30570 | -------- Summary: end -------- 20:19:10 INFO - PROCESS | 30570 | 20:19:11 INFO - TEST-INFO | 30570: exit 0 20:19:11 INFO - TEST-OK | kraken | took 61037ms 20:19:11 INFO - TEST-START | v8_7 20:19:11 INFO - operating with platform_type : linux_ 20:19:11 INFO - Initialising browser for v8_7 test... 20:19:11 INFO - TEST-INFO | started process 30858 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjywyhA/profile http://localhost:47649/getInfo.html) 20:19:15 INFO - PROCESS | 30858 | 20:19:15 INFO - PROCESS | 30858 | (process:30933): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:19:15 INFO - PROCESS | 30858 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:19:16 INFO - PROCESS | 30858 | __metrics Screen width/height:1600/1200 20:19:16 INFO - PROCESS | 30858 | colorDepth:24 20:19:16 INFO - PROCESS | 30858 | Browser inner width/height: 1024/697 20:19:16 INFO - PROCESS | 30858 | __metrics 20:19:16 INFO - PROCESS | 30858 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:19:16 INFO - PROCESS | 30858 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:19:17 INFO - TEST-INFO | 30858: exit 0 20:19:17 INFO - Browser initialized. 20:19:17 INFO - Running cycle 1/1 for v8_7 test... 20:19:17 INFO - TEST-INFO | started process 30982 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjywyhA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:19 INFO - PROCESS | 30982 | 20:19:19 INFO - PROCESS | 30982 | (process:31041): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:19:29 INFO - PROCESS | 30982 | RSS: Main: 150433792 20:19:29 INFO - PROCESS | 30982 | 20:19:51 INFO - PROCESS | 30982 | Cycle 1(1): loaded http://localhost:47649/tests/v8_7/run.html (next: http://localhost:47649/tests/v8_7/run.html) 20:19:52 INFO - PROCESS | 30982 | RSS: Main: 147210240 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | __start_tp_report 20:19:52 INFO - PROCESS | 30982 | _x_x_mozilla_page_load 20:19:52 INFO - PROCESS | 30982 | _x_x_mozilla_page_load_details 20:19:52 INFO - PROCESS | 30982 | |i|pagename|runs| 20:19:52 INFO - PROCESS | 30982 | |0;Richards;170.91095539224065 20:19:52 INFO - PROCESS | 30982 | |1;DeltaBlue;188.67924528301887 20:19:52 INFO - PROCESS | 30982 | |2;Encrypt;279.4857462269424 20:19:52 INFO - PROCESS | 30982 | |3;Decrypt;5246.073298429319 20:19:52 INFO - PROCESS | 30982 | |4;RayTrace;1095.1859956236324 20:19:52 INFO - PROCESS | 30982 | |5;Earley;735.8351729212657 20:19:52 INFO - PROCESS | 30982 | |6;Boyer;12345.67901234568 20:19:52 INFO - PROCESS | 30982 | |7;RegExp;40450.98039215686 20:19:52 INFO - PROCESS | 30982 | |8;Splay;568.5048322910744 20:19:52 INFO - PROCESS | 30982 | |9;NavierStokes;4840.579710144928 20:19:52 INFO - PROCESS | 30982 | __end_tp_report 20:19:52 INFO - PROCESS | 30982 | __startTimestamp1452485992201__endTimestamp 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | ------- Summary: start ------- 20:19:52 INFO - PROCESS | 30982 | Number of tests: 10 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#0] Richards Cycles:1 Average:170.91 Median:170.91 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 170.9 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 188.7 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 279.5 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 5246.1 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#4] RayTrace Cycles:1 Average:1095.19 Median:1095.19 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 1095.2 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#5] Earley Cycles:1 Average:735.84 Median:735.84 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 735.8 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 12345.7 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#7] RegExp Cycles:1 Average:40450.98 Median:40450.98 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 40451.0 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#8] Splay Cycles:1 Average:568.50 Median:568.50 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 568.5 20:19:52 INFO - PROCESS | 30982 | 20:19:52 INFO - PROCESS | 30982 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:19:52 INFO - PROCESS | 30982 | Values: 4840.6 20:19:52 INFO - PROCESS | 30982 | -------- Summary: end -------- 20:19:52 INFO - PROCESS | 30982 | 20:19:53 INFO - TEST-INFO | 30982: exit 0 20:19:53 INFO - TEST-OK | v8_7 | took 41566ms 20:19:53 INFO - SUITE-END | took 1213s 20:19:53 INFO - Completed test suite (00:20:13) 20:19:53 INFO - Working with test: dromaeo_css 20:19:53 INFO - Generating results file: dromaeo_css 20:19:53 INFO - Working with test: kraken 20:19:53 INFO - Generating results file: kraken 20:19:53 INFO - javascript benchmark 20:19:53 INFO - Working with test: v8_7 20:19:53 INFO - Generating results file: v8_7 20:19:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:19:53 INFO - process_Request line: dromaeo_css 6835.58 graph.html#tests=[[72,64,43]] 20:19:53 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:53 INFO - process_Request line: kraken 1523.20 graph.html#tests=[[232,64,43]] 20:19:53 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:53 INFO - process_Request line: v8_7 20331.18 graph.html#tests=[[230,64,43]] 20:19:53 INFO - RETURN: dromaeo_css: 6835.58 20:19:53 INFO - RETURN: kraken: 1523.20 20:19:53 INFO - RETURN: v8_7: 20331.18 20:19:53 INFO - javascript benchmark 20:19:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3140.5603215549827, 3193.5050067239586, 3202.455582550966, 3226.9515957260633, 3243.902682919512, 5155.690658560479, 5178.223266510021, 5226.8693282667955, 5233.685978841268, 5270.631055826084, 5101.081805275049, 5186.0665080285535, 5215.843524694255, 5223.0, 5291.1798671205925, 4482.820687172525, 4742.264948932912, 4915.188993816016, 4921.753912304388, 4962.181240095398, 4721.69308994916, 4792.185328494147, 4820.276958456242, 4867.902641947159, 4879.438864530571, 4755.809767609291, 4807.78364973577, 4869.805207791684, 4875.658703890729, 4886.584640305578, 4803.639727020487, 4809.78355973982, 4810.158222311116, 4850.417949846006, 4858.489858564871, 4738.47876733559, 4819.373481447425, 4824.782884770194, 4840.564349208553, 4858.368412106439, 5068.239764035424, 5074.213496907985, 5092.490750924915, 5160.793568257265, 5166.509181627739, 5619.213310136584, 5626.071698169797, 5632.549396048347, 5636.49271565557, 5639.774409023634, 5635.21107045014, 5656.349519805234, 5658.0, 5667.546596272288, 5684.403137670526, 5195.454477279869, 5250.3962044364625, 5299.258103865462, 5330.280412144389, 5384.165454354581, 5718.428157184248, 5737.053386191315, 5737.971310143506, 5741.712914354265, 5747.971260143672, 5414.35027796667, 5532.6680399176175, 5535.059039963216, 5538.667679939216, 5540.63985840919, 5654.604177707521, 5680.5171560417, 5748.367679555246, 5755.62588431759, 5816.825495235065, 5544.528715059185, 5585.636933599384, 5589.161625756088, 5592.217089607459, 5596.860078497989, 5506.394296627368, 5577.637453565505, 5579.051561234519, 5594.244776955059, 5623.775048998076, 4318.0, 4358.302671572533, 4358.607725304738, 4387.166438376698, 4389.62688171509, 3924.7645141291614, 3973.5430425501436, 3974.940375894364, 3991.560928297885, 4022.879313620596, 5196.298499702568, 5260.158374660036, 5302.761375738101, 5367.194920761839, 5382.542483888913, 5676.517496012885, 5695.7152142392715, 5752.511036561856, 5754.165645981309, 5763.991301522216, 5329.573634109262, 5345.064613692588, 5357.142857142839, 5372.301600791872, 5382.381026181961, 4697.154512187771, 4790.377250957354, 4802.639802014863, 4871.025794841046, 4895.534924182197, 5822.912656310244, 5839.240898683144, 5839.737211825478, 5846.152307915413, 5863.912041319383, 5606.439356064361, 5617.466340697627, 5631.971840140937, 5650.63270887391, 5652.293463317085, 5629.099344104923, 5754.338251101177, 5859.560532959959, 5959.612625179349, 6012.368701286302, 5550.222968784293, 5552.7223638818705, 5555.3333599966645, 5556.749946252347, 5557.472040156179, 5640.041192997118, 5663.688497132533, 5664.26364572603, 5664.716764161858, 5668.234788303691, 5456.508914197741, 5532.86167845791, 5571.997040532743, 5594.4125866785025, 5667.149927510906, 5481.588880833874, 5497.697626630414, 5505.229267902417, 5547.140193270049, 5568.16477528374, 5322.840314790563, 5393.514583687487, 5437.619366644297, 5452.345718513804, 5489.149181876815, 5480.150576660624, 5530.198121272473, 5591.916121258103, 5598.636088654224, 5652.971735141298, 5404.108322126962, 5423.83728488146, 5432.728363581726, 5436.0758671026815, 5455.318085239345], "unit": "score", "name": "dojo.html", "value": 5210.730780151266}, {"lowerIsBetter": false, "replicates": [540.6837000354792, 567.7870798450579, 598.7096258314717, 605.0923614578131, 632.3897438971397, 34370.48444273338, 35382.8155466008, 35449.291014179704, 35512.28975420493, 35519.999999999935, 37851.0, 38456.88487133206, 38467.23065538694, 38806.61193388065, 38892.80553597235, 8435.156484351563, 8634.870476942819, 8672.52301123438, 8673.219410253076, 8693.304535637166, 8374.665013399486, 8461.661533538681, 8496.150384961516, 8518.190771876662, 8564.272036876873, 8434.114417986084, 8522.488650680947, 8550.144985501462, 8577.185167409118, 8588.312934965188, 8375.62309696062, 8518.616662250213, 8543.316534677242, 8551.444156129832, 8555.443896146793, 8395.874061889077, 8499.405041647087, 8499.702510412106, 8503.064662887078, 8510.829783404297, 32409.837950810095, 32485.350292994008, 32859.0, 32914.50628240578, 33013.50479742806, 3406.9829650851834, 3545.8758943436856, 3820.560635526894, 3859.671927886133, 4049.1901619675887, 28161.310321380577, 28405.14784556446, 28500.572491412644, 28581.714182858323, 28782.856085719646, 3837.0599203195115, 3851.441540976543, 3912.3349030664854, 4028.8992775180564, 4066.207089617526, 260153.0, 261330.0, 263198.0, 263471.0, 264173.9999999981, 53748.46251537435, 55862.72068639631, 56682.43317566854, 56717.43282567204, 56901.430985689614, 47915.281270780964, 64039.679801600694, 65948.34051659518, 66049.33950660528, 66055.0, 15761.133137677309, 15991.0, 16047.876648634718, 16054.518364449084, 16113.597160071093, 12136.939315303367, 12266.938665306616, 12327.890489855956, 12331.445084971198, 12353.814692779615, 19182.328618498286, 19190.520236993907, 19218.903905480383, 19524.316648917218, 19897.403077907686, 7735.7679269622, 7905.169957154531, 8014.479058861155, 8021.518708877369, 8023.558704271204, 901.8827552418144, 985.3742873275521, 1004.7588578741049, 1073.6295977887617, 1098.6923661374667, 28755.28111797222, 28817.279568010967, 28997.855010724812, 29186.416271674447, 29246.0, 974.3958745577787, 1040.8490768838476, 1043.7338478687886, 1087.7552550676035, 1146.2606618731038, 14119.294035298399, 15317.923410382877, 15840.60398490047, 15883.682326353408, 16110.597235068983, 332564.0, 338695.0, 339482.0, 339489.0, 339614.0, 50357.244641330406, 50515.0, 51238.48761512337, 51240.23139652908, 51245.74377128165, 1324.892832220129, 1327.87385198406, 1335.4324412124809, 1335.4991878045732, 1343.2947702456092, 28069.298267543476, 29065.854670726512, 29126.0, 29357.7064229355, 29366.853165734035, 44345.33481997837, 44648.33027504525, 44685.0, 44777.0, 44802.10395792131, 311381.0, 314572.0, 315147.0, 315626.0, 316768.2423818269, 30865.69134308628, 31509.684903150675, 32255.516167257978, 32333.838330809136, 32337.676623233467, 40846.387304191056, 41300.793496032325, 41902.37146442745, 42308.57691423046, 42661.57338426576, 34896.30207395787, 35015.82492087523, 35069.82465087761, 35114.297714046086, 35546.46680299849, 35163.47254791129, 35318.64681353256, 35648.28703425969, 35703.46444803382, 35916.0, 34749.1312717174, 34957.82521087378, 34961.65038349584, 36173.0, 37002.814985924895, 29103.563446547894, 31659.366812663156, 31771.20571985719, 32114.839425803657, 32439.351212976082, 24206.15278465245, 24451.0, 24466.266012019667, 24898.253052408458, 24991.87504062468], "unit": "score", "name": "ext.html", "value": 18300.821155882408}, {"lowerIsBetter": false, "replicates": [358.37105879182036, 360.4575114452748, 363.8090002748558, 364.0353064379394, 365.6234078898734, 15823.683526329467, 16612.584685382855, 16843.91578042111, 17486.475405737816, 17618.91190544047, 10345.948270258637, 10505.581746464226, 16357.427490037851, 16761.161941902916, 16789.832101678978, 4552.226121559334, 5377.623566350357, 5420.783168673268, 5423.918641220384, 5429.077056900317, 5008.874778130539, 5190.870228244286, 5263.789448422059, 5324.1747529133045, 5328.706921119337, 5308.044551980642, 5311.760970756306, 5336.759845806929, 5337.412884582693, 5347.679139251638, 5063.569596584295, 5280.155175171954, 5322.4411436799155, 5330.093884039684, 5353.544948679367, 4777.5222477752295, 4780.689255198401, 4811.4707382187935, 4812.7352995585225, 4826.638002149853, 17998.1000949952, 18655.720164197548, 18925.33761318361, 19612.411627651192, 20354.982250887395, 2048.5185981294385, 2083.114676262582, 2125.5855108253895, 2182.890855457221, 2212.513247085639, 9033.548322583845, 9399.295052871063, 12007.159498835084, 12783.701201907641, 13063.738725225443, 1841.686913224755, 1852.8239817217343, 1855.6010457751513, 1876.690346092893, 1939.5442071113278, 50960.49039509631, 51056.0, 53852.0, 55527.72236138793, 56376.15435768467, 9344.813103737888, 9555.90444095564, 9702.951485242529, 9709.563069661883, 9733.805323893483, 12162.08784341178, 12415.689607759698, 12686.11197216186, 13389.129706569041, 13437.395317210554, 7577.16651168371, 7822.1004584472375, 7895.60521973899, 7916.643751031217, 7935.841283174304, 7172.0676312079095, 7364.77905662831, 7377.299156580117, 7496.400287977058, 7658.65536050879, 4391.407160033355, 4426.9778651106535, 4494.70784399013, 4525.637948964075, 4545.545445455428, 1847.3995951315876, 1891.6500447417272, 1909.8281154696144, 1931.2950772968047, 1950.2686492565288, 418.9601987811214, 905.3707673167218, 911.3119594706087, 965.6958058211641, 988.2439933450916, 9984.201263899016, 10346.22403319754, 10478.63324783629, 15622.921885390728, 16209.270582823801, 892.9241014513709, 933.1927882381691, 990.1039559198937, 993.8012397520525, 1042.4162469017224, 7740.4194685398825, 8894.110588941054, 9114.0, 9128.40665356763, 9936.20510359184, 348313.0, 356921.0, 357120.0, 359470.0, 489009.0, 61242.0, 72086.63956680182, 73365.0, 75375.0, 77025.6148719264, 1166.1137535472933, 1200.11911852292, 1204.9638510844688, 1206.1315852586124, 1208.1301462946665, 14261.144331340152, 14335.498257560936, 14825.851741482447, 14864.925675371554, 14959.551213463614, 26618.467630647665, 27285.317867053483, 31538.526922096647, 31736.523952140273, 32651.0, 41524.169516610105, 43636.34545481884, 44547.554524455634, 44588.55411445974, 49550.50449495459, 9374.812503750023, 9658.179054780423, 9663.565139568876, 10017.39895606266, 10130.138938190335, 11352.94323528377, 11535.134864885335, 11821.0, 12063.81904271419, 12139.696507587381, 6698.56459330142, 6837.35045170708, 7148.320909513588, 7196.712131514891, 7244.166920804175, 7017.649117544204, 7194.964025179841, 7503.09962804467, 7508.849823003618, 7537.623118844145, 7315.48791584584, 7355.852882942204, 7408.740694075897, 7442.516236444614, 7486.064241969754, 9813.411195328017, 9968.850467243143, 10145.746356341151, 10175.84736228972, 10384.844227336445, 10295.176385889261, 10386.169106471312, 10498.212634052325, 10508.947455262674, 10580.259381843505], "unit": "score", "name": "jquery.html", "value": 7939.51973562504}, {"lowerIsBetter": false, "replicates": [1443.5308524729464, 1478.231319713749, 1642.6057746140923, 1766.3199668127768, 1791.0954967741288, 7048.506604537684, 7166.283371662831, 7234.421246300297, 7287.562746235223, 7335.7432489862795, 7326.926730732691, 7352.705891764336, 7367.079115110611, 7419.517731347459, 7445.702171913131, 2266.829987750917, 2284.931452056441, 2285.451491642002, 2286.314105768271, 2292.6790249365104, 2302.700648915639, 2333.7199536055696, 2334.9066037358484, 2343.789058984691, 2344.542814151241, 2030.4111807575784, 2064.2465500092435, 2201.570693714726, 2297.8161747060194, 2310.803581695558, 2238.764929682376, 2239.29462219402, 2242.7869352411494, 2243.371855880356, 2246.550689862026, 2132.0938601094626, 2165.935021949344, 2167.1873047607146, 2179.095675294751, 2181.5418762059985, 7126.64366781664, 7160.319769621878, 7184.928150718478, 7197.568145911262, 7207.0, 4578.35902973584, 4690.624750019991, 4736.0, 4751.073540659573, 4774.16452120881, 3029.4546981543313, 3040.1183656739518, 3086.6450358208867, 3095.628524577065, 3140.262038420969, 999.7400675824338, 1007.2948935745007, 1022.6983040003142, 1040.547361897577, 1078.5577913055688, 9847.655332063416, 9926.851097233548, 9946.502674866228, 9976.750581235454, 9977.451240181786, 4177.101923086551, 4195.370694395865, 4214.093969796509, 4237.449131612932, 4279.679024073144, 8227.341812654973, 8266.090730019692, 8282.088970213272, 8294.34113177367, 8298.087210406971, 4696.929546056812, 4697.154512187771, 4705.670603057822, 4714.882127946828, 4742.051589682077, 4350.60844523988, 4357.934630980538, 4361.062371590124, 4375.0, 4384.05742765307, 3403.1151900506047, 3421.469672200813, 3432.7768695034742, 3442.8106454145263, 3463.8441270142903, 1091.812897537935, 1111.4498323330004, 1114.3146964616703, 1119.3451830679144, 1125.887411258884, 1040.490159821682, 1042.3276986343765, 1096.4156793433413, 1211.878812118781, 1298.9610311690665, 6868.553544019623, 6874.725010999604, 6903.6548172591165, 6919.481038922101, 6944.930550694529, 1078.2075174746556, 1110.4225802582612, 1111.2554588425774, 1124.4714983957526, 1127.9154063445274, 5403.297571315704, 5407.215953686693, 5445.319335083114, 5449.6730196188355, 5452.618316717871, 8299.6680132794, 8404.327653787805, 8476.321894248445, 8585.570721463902, 8829.0, 8185.222403871623, 8228.62971166299, 8237.752867413867, 8242.958785206036, 8393.748187554384, 6720.092787473628, 6802.081718967876, 6867.484938629723, 6880.552764070319, 6908.549204666976, 6785.694643740945, 6820.658967051727, 6824.590524568542, 6832.350926661959, 6837.803384407609, 7606.733764318223, 7742.032245969254, 7944.245296696805, 7957.482763620346, 8023.0, 8027.2775450209765, 8146.185381461806, 8247.793805154919, 8283.17168283167, 8327.417080804285, 6532.5753826001155, 6548.967255163694, 6601.174853143357, 6611.636360000246, 6621.702023409054, 7036.753713619999, 7130.393916516947, 7132.465065120033, 7138.535995160298, 7158.961950517041, 6563.573367731082, 6600.20523396169, 6725.630090345078, 6852.903097301026, 6890.1731792183255, 6582.80251592453, 6672.4328432081875, 6700.631465269457, 6705.765298214539, 6762.459003279628, 6603.009548567561, 6616.4045235929, 6646.734130634721, 6658.700358483783, 6662.966685166737, 6106.114613380946, 6166.660833654192, 6257.7184026719815, 6285.402886725754, 6296.842578935563, 6116.541259405473, 6122.204113465221, 6142.04798256271, 6160.568760186744, 6166.445019948047], "unit": "score", "name": "mootools.html", "value": 4321.522477703471}, {"lowerIsBetter": false, "replicates": [327.3469428490163, 334.7338865601846, 344.4798354484727, 348.58344278587066, 351.93137338219043, 6247.6251424914535, 6250.5312101592335, 6335.683215839207, 6355.872882542347, 6448.838779030527, 6257.561970662044, 6300.401461861127, 6318.557700960934, 6318.905216421757, 6327.905081423783, 4808.158572249859, 4815.735134567597, 4820.734859582739, 4824.228123500241, 4824.4934281900505, 4791.760411979404, 4804.279358096296, 4825.276208568725, 4825.879353016167, 4828.082664293791, 4675.462321832999, 4781.521847815208, 4793.976030119845, 4801.567858892699, 4804.639652026094, 4765.189917713979, 4784.99515101829, 4787.066522028206, 4787.6648634595595, 4798.856034318976, 4172.853950111731, 4174.060836311836, 4183.602557757039, 4185.644220241283, 4188.350805625133, 6029.969850150765, 6030.608010479349, 6034.004389275764, 6035.426634469718, 6040.335563088057, 5471.425500322449, 5593.496585307342, 5594.748236329375, 5598.1602759585985, 5607.663540187602, 6698.8995165072565, 6702.229243636995, 6704.5306828522025, 6710.966445167792, 6726.966365168192, 4603.0, 4613.5847773700525, 4616.884577885579, 4620.3762492063815, 4624.606908412789, 6721.0926524919, 6889.104416425833, 6960.234374218832, 6966.5471744336455, 7027.543209691354, 4616.6537509686905, 4631.560001799824, 4633.49031606523, 4640.744759038285, 4642.767861606906, 4696.694714843524, 4706.717596944126, 4706.788194531186, 4713.269443236304, 4722.315264286659, 5480.123180291134, 5481.424450432647, 5482.5613950883835, 5488.039593071197, 5491.313585801775, 6545.869082618321, 6671.39957403836, 6676.599404035774, 6699.76550820719, 6704.4301234395625, 1644.925978330978, 1660.1616183827332, 1684.6546457976085, 1687.5527985083963, 1688.282479946018, 1118.9216754827085, 1132.6998345438465, 1132.7734453109247, 1134.4554613785429, 1142.731458107344, 6290.748370065237, 6298.338674439118, 6302.432781049728, 6309.905351419732, 6312.684365781693, 6768.221654509696, 6776.017477465838, 6809.489288303397, 6812.62530560814, 6829.658517074126, 6119.082137679384, 6188.009918413032, 6282.371762823773, 6291.811245662546, 6308.211473565804, 3678.2275722098125, 3690.907727306785, 3693.0582701410967, 3697.3159965406485, 3704.4258139988347, 7074.469414793808, 7096.929030709627, 7145.249748776408, 7148.463865210026, 7156.785296441115, 6819.454443644497, 6976.860462790716, 6981.2669669684965, 6988.056612357368, 7000.439964802804, 7186.0, 7204.135503739585, 7211.747588834365, 7219.3502584766575, 7284.854302914018, 6846.931530684629, 6850.246472887879, 6862.245153033262, 6894.207166175954, 6933.687984040629, 6630.9668451657435, 6826.351496608013, 6827.21487028998, 6836.726530938707, 6855.657217139223, 7282.12614486265, 7282.417406607353, 7289.708411663474, 7294.1247050354295, 7306.744263950736, 4704.29435584665, 4734.502877197845, 4737.66836321468, 4744.240921452689, 4745.786439610157, 6708.758879607289, 6876.037354770237, 6909.965450172918, 6925.792226233221, 6935.514513983972, 6659.433948114464, 6715.328467153246, 6723.899141512979, 6724.798256052326, 6731.091302674076, 6681.5656982296, 6701.262861085374, 6701.899471507833, 6717.630530320879, 6727.293634168342, 6446.452051575481, 6544.6727663617585, 6558.557117434157, 6560.376764207393, 6563.04835798816, 6689.76585819494, 6722.932770672231, 6732.0, 6735.191776986793, 6735.595864248161, 6504.252011018793, 6527.0, 6563.704633291609, 6590.7693230736695, 6601.933980660324], "unit": "score", "name": "prototype.html", "value": 5019.009848102624}, {"lowerIsBetter": false, "replicates": [724.4892350892621, 777.8249893773901, 798.2217338095354, 843.5444859775723, 852.8422241885252, 13006.219626822385, 13104.14823036502, 13127.08110432269, 13133.080684352075, 13235.205887646736, 12975.545855895045, 13029.21824690517, 13036.348182590857, 13044.673883152926, 13048.673783155426, 658.6081281637418, 663.9136912201407, 774.7404619452476, 790.2492631999595, 792.7027364738224, 803.586153131138, 806.0649646410166, 807.5719868469721, 808.0343988933228, 812.2324403438753, 841.238678995507, 841.5960339037266, 843.1315744782884, 846.7798372423152, 846.8772028055928, 841.6128580852815, 841.8400503904238, 844.932405407566, 845.7631863078348, 846.090452763282, 620.8944479438507, 621.8103478439074, 623.6320570863212, 623.6850390552787, 628.5568674084805, 13456.058075934689, 13470.663233419145, 13495.392707328096, 13499.797503037462, 13511.0, 12815.359232038454, 13090.410931508104, 13215.074944753775, 13258.270795106266, 13338.533151339656, 10177.287589868713, 10284.588616455332, 10482.213833962483, 10645.323058742924, 10808.783824323547, 3631.6005239423644, 3669.101070237809, 3680.6319368063246, 3712.9071773205615, 3777.1690228149764, 42833.0, 42876.35685464721, 42884.356734649, 43363.56636433627, 43543.0, 9851.704448866545, 10267.229957753198, 10272.135299807565, 10347.94826025865, 10696.090832279187, 18433.170507327202, 18437.815621843878, 18494.075296235136, 18504.81495185031, 18516.16677249527, 7238.782836514913, 7500.812479687942, 7836.216378362118, 8011.599420028975, 8058.073321568095, 4431.8448854289945, 4444.2444784386735, 4460.0, 4487.349334346567, 4551.431071116111, 3023.0779612218485, 3049.207206126423, 3051.5422686596744, 3053.0535533984535, 3055.2667359833927, 554.3901708121034, 573.5039191099752, 574.0499473371576, 575.1516513143081, 579.2672269578986, 572.5076434266527, 599.6132494540997, 624.3756243756244, 631.2614241337554, 651.9380658837403, 8468.195521425454, 9424.528773561295, 9448.763780905394, 9467.431954082776, 9496.47769372691, 513.2352794336412, 516.839779668304, 534.7513406266105, 543.7933585237663, 546.9097598896217, 3581.83881725323, 3925.2542017017245, 3956.129651476728, 3990.780507072139, 4041.939370909439, 54577.45422545803, 54704.45295547073, 54908.725456372464, 55033.449665503635, 55130.72434637801, 49046.0, 55563.72218138883, 55884.0, 56693.43306566882, 57112.0, 42897.785511072245, 44141.0, 44807.55192448099, 45087.872803179525, 45243.0, 8184.672613095409, 8323.750287491384, 8685.218330350299, 8780.956095219482, 8791.824163516821, 33702.32595348128, 33952.0, 34508.65491345055, 34603.65396346105, 34654.133646658025, 39362.21275574415, 40577.79711101425, 42984.78507607442, 43164.568354316056, 43243.0, 10605.310654807412, 10827.783444331228, 10845.837312440477, 11009.61466348674, 11070.225084244348, 12003.1597788154, 12129.939350303192, 12161.270323780602, 12205.69485762863, 12591.685207869876, 10750.838737418788, 10988.0, 11031.669049928514, 11378.829317560409, 11627.418629068681, 11141.888581114084, 11377.374244416636, 11521.88478115208, 11774.80535036913, 11990.100742444178, 10473.266871318934, 10547.156227501935, 10605.787884242427, 10663.360198388122, 10715.571377144826, 8559.443636163629, 8727.476351418934, 8826.646934122564, 9131.863022054542, 9172.495512746864, 8860.424072435271, 9075.27397808187, 9363.953180234055, 9553.713388598353, 9646.662366817127], "unit": "score", "name": "yui.html", "value": 6211.501555767533}], "name": "dromaeo_css", "value": 6835.580391038476}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 114.0, 111.0, 113.0, 123.0, 112.0, 114.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 149.0, 162.0, 128.0, 156.0, 156.0, 131.0, 168.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 164.0, 161.0, 162.0, 161.0, 162.0, 178.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 75.0, 75.0, 72.0, 146.0, 73.0, 74.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 97.0, 96.0, 96.0, 150.0, 95.0, 97.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 98.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 60.0, 58.0, 59.0, 60.0, 59.0, 63.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 87.0, 85.0, 86.0, 86.0, 87.0, 88.0, 99.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 116.0, 127.0, 121.0, 119.0, 128.0, 126.0, 117.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [142.0, 152.0, 154.0, 151.0, 154.0, 145.0, 152.0, 148.0, 155.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.5}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 67.0, 71.0, 68.0, 73.0, 73.0, 70.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1523.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.91095539224065], "unit": "score", "name": "Richards", "value": 206.552002}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1095.1859956236324], "unit": "score", "name": "RayTrace", "value": 675.6742717282718}, {"lowerIsBetter": false, "replicates": [735.8351729212657], "unit": "score", "name": "Earley", "value": 905.723217}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [40450.98039215686], "unit": "score", "name": "RegExp", "value": 22.520714978187108}, {"lowerIsBetter": false, "replicates": [568.5048322910744], "unit": "score", "name": "Splay", "value": 143.34266900000006}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20331.181945845572}]} 20:19:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20331.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1523.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6835.58"}}} 20:19:53 INFO - Return code: 0 20:19:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:19:53 INFO - # TBPL SUCCESS # 20:19:53 INFO - Running post-action listener: _resource_record_post_action 20:19:53 INFO - Running post-run listener: _resource_record_post_run 20:19:54 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8192; Write bytes: 557637632; Read time: 552; Write time: 887888 20:19:54 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 4096; Write bytes: 239472640; Read time: 264; Write time: 609080 20:19:54 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318164992; Read time: 288; Write time: 278808 20:19:54 INFO - Running post-run listener: _upload_blobber_files 20:19:54 INFO - Blob upload gear active. 20:19:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:19:54 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 20:19:54 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'] 20:19:54 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 20:19:54 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:19:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:56 INFO - (blobuploader) - INFO - Done attempting. 20:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:56 INFO - (blobuploader) - INFO - Done attempting. 20:19:56 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:56 INFO - Return code: 0 20:19:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:19:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/527fdf7e0ab28a013030dc538f45763e73bbd3f37f9e32540b9573b5bb9fc7575316a66c4d6e45520311cee78470154130acbaaa5814a56dcc0d88fe5a78c082", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ea846f20c32e262aef8126b5d114f2bee8bf85e3fb9dda7b1ca3357012bb50670847fe009e4972b00e2cffdceb14243d3b155cbf2e4800852a04d849d383b85"} 20:19:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:19:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:19:56 INFO - Contents: 20:19:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/527fdf7e0ab28a013030dc538f45763e73bbd3f37f9e32540b9573b5bb9fc7575316a66c4d6e45520311cee78470154130acbaaa5814a56dcc0d88fe5a78c082", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ea846f20c32e262aef8126b5d114f2bee8bf85e3fb9dda7b1ca3357012bb50670847fe009e4972b00e2cffdceb14243d3b155cbf2e4800852a04d849d383b85"} 20:19:56 INFO - Copying logs to upload dir... 20:19:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.795526 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-10 20:19:56.569968) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 20:19:56.573967) ========= 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=df17445c3590ff7897617a0e00000225-1452480755.548566-174193274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/527fdf7e0ab28a013030dc538f45763e73bbd3f37f9e32540b9573b5bb9fc7575316a66c4d6e45520311cee78470154130acbaaa5814a56dcc0d88fe5a78c082", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ea846f20c32e262aef8126b5d114f2bee8bf85e3fb9dda7b1ca3357012bb50670847fe009e4972b00e2cffdceb14243d3b155cbf2e4800852a04d849d383b85"} build_url:https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/W9q1xNFtTrajvqSKXlrR-g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/527fdf7e0ab28a013030dc538f45763e73bbd3f37f9e32540b9573b5bb9fc7575316a66c4d6e45520311cee78470154130acbaaa5814a56dcc0d88fe5a78c082", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ea846f20c32e262aef8126b5d114f2bee8bf85e3fb9dda7b1ca3357012bb50670847fe009e4972b00e2cffdceb14243d3b155cbf2e4800852a04d849d383b85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 20:19:56.599005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:19:56.599326) ========= 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=df17445c3590ff7897617a0e00000225-1452480755.548566-174193274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:19:56.686016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 20:19:56.686436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 20:19:56.687244) ========= ========= Total master_lag: 0.24 =========