builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1450714756.61 results: success (0) buildid: 20151221053036 builduid: bde663f589e4469097e7585c9b96dad3 revision: 12019f25b95191d629f5b605f894b0d0f22b1e37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.609890) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.610410) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.610736) ========= 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=d6a7e047ef025f707024e163000001c3-1450714755.907910-840275645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006234 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.633310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.633609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.646798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.647100) ========= 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=d6a7e047ef025f707024e163000001c3-1450714755.907910-840275645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004592 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.696619) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.696933) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.697323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.697634) ========= 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=d6a7e047ef025f707024e163000001c3-1450714755.907910-840275645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 08:19:16-- 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% 140M=0s 2015-12-21 08:19:17 (140 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.896974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.897342) ========= 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=d6a7e047ef025f707024e163000001c3-1450714755.907910-840275645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017701 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.946935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:16.947347) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 12019f25b95191d629f5b605f894b0d0f22b1e37 --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 12019f25b95191d629f5b605f894b0d0f22b1e37 --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=d6a7e047ef025f707024e163000001c3-1450714755.907910-840275645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 08:19:17,206 truncating revision to first 12 chars 2015-12-21 08:19:17,206 Setting DEBUG logging. 2015-12-21 08:19:17,206 attempt 1/10 2015-12-21 08:19:17,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/12019f25b951?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 08:19:17,780 unpacking tar archive at: fx-team-12019f25b951/testing/mozharness/ program finished with exit code 0 elapsedTime=0.843890 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:17.804456) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:17.804837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:17.812699) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:17.813011) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 08:19:17.813475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-12-21 08:19:17.813798) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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=d6a7e047ef025f707024e163000001c3-1450714755.907910-840275645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:19:18 INFO - MultiFileLogger online at 20151221 08:19:18 in /builds/slave/test-pgo 08:19:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:19:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:19:18 INFO - {'append_to_log': False, 08:19:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:19:18 INFO - 'blob_upload_branch': 'Fx-Team', 08:19:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:19:18 INFO - 'branch': 'Fx-Team', 08:19:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:19:18 INFO - 'config_files': ('talos/linux_config.py',), 08:19:18 INFO - 'default_actions': ('clobber', 08:19:18 INFO - 'read-buildbot-config', 08:19:18 INFO - 'download-and-extract', 08:19:18 INFO - 'populate-webroot', 08:19:18 INFO - 'create-virtualenv', 08:19:18 INFO - 'install', 08:19:18 INFO - 'run-tests'), 08:19:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:19:18 INFO - 'download_minidump_stackwalk': True, 08:19:18 INFO - 'download_symbols': 'ondemand', 08:19:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:19:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:19:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:19:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:19:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:19:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:19:18 INFO - 'installer_path': 'installer.exe', 08:19:18 INFO - 'log_level': 'info', 08:19:18 INFO - 'log_name': 'talos', 08:19:18 INFO - 'log_to_console': True, 08:19:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:19:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:19:18 INFO - 'opt_config_files': (), 08:19:18 INFO - 'pip_index': False, 08:19:18 INFO - 'sps_profile': False, 08:19:18 INFO - 'sps_profile_interval': 0, 08:19:18 INFO - 'suite': 'dromaeojs-e10s', 08:19:18 INFO - 'system_bits': '64', 08:19:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:19:18 INFO - 'title': 'talos-linux64-ix-016', 08:19:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:19:18 INFO - 'use_talos_json': True, 08:19:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:19:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:19:18 INFO - 'work_dir': 'build'} 08:19:18 INFO - ##### 08:19:18 INFO - ##### Running clobber step. 08:19:18 INFO - ##### 08:19:18 INFO - Running pre-action listener: _resource_record_pre_action 08:19:18 INFO - Running main action method: clobber 08:19:18 INFO - rmtree: /builds/slave/test-pgo/build 08:19:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:19:18 INFO - Running post-action listener: _resource_record_post_action 08:19:18 INFO - ##### 08:19:18 INFO - ##### Running read-buildbot-config step. 08:19:18 INFO - ##### 08:19:18 INFO - Running pre-action listener: _resource_record_pre_action 08:19:18 INFO - Running main action method: read_buildbot_config 08:19:18 INFO - Using buildbot properties: 08:19:18 INFO - { 08:19:18 INFO - "project": "", 08:19:18 INFO - "product": "firefox", 08:19:18 INFO - "script_repo_revision": "production", 08:19:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:19:18 INFO - "repository": "", 08:19:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:19:18 INFO - "buildid": "20151221053036", 08:19:18 INFO - "pgo_build": "True", 08:19:18 INFO - "basedir": "/builds/slave/test-pgo", 08:19:18 INFO - "buildnumber": 396, 08:19:18 INFO - "slavename": "talos-linux64-ix-016", 08:19:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:19:18 INFO - "platform": "ubuntu64_hw", 08:19:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:19:18 INFO - "branch": "fx-team", 08:19:18 INFO - "repo_path": "integration/fx-team", 08:19:18 INFO - "revision": "12019f25b95191d629f5b605f894b0d0f22b1e37", 08:19:18 INFO - "stage_platform": "linux64-pgo", 08:19:18 INFO - "builduid": "bde663f589e4469097e7585c9b96dad3", 08:19:18 INFO - "slavebuilddir": "test" 08:19:18 INFO - } 08:19:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:19:18 INFO - Running post-action listener: _resource_record_post_action 08:19:18 INFO - ##### 08:19:18 INFO - ##### Running download-and-extract step. 08:19:18 INFO - ##### 08:19:18 INFO - Running pre-action listener: _resource_record_pre_action 08:19:18 INFO - Running main action method: download_and_extract 08:19:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:19: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')]} 08:19:18 INFO - https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/test_packages.json 08:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/test_packages.json 08:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:19:19 INFO - Downloaded 1302 bytes. 08:19:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:19:19 INFO - Using the following test package requirements: 08:19:19 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:19 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:19:19 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:19 INFO - u'jsshell-linux-x86_64.zip'], 08:19:19 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:19:19 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:19 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:19:19 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:19:19 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:19:19 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:19 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:19:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:19:19 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')]} 08:19:19 INFO - https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:19:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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 08:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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 08:19:20 INFO - Downloaded 23176434 bytes. 08:19:20 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 08:19:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:20 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 08:19:21 INFO - Return code: 0 08:19:21 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 08:19:21 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')]} 08:19:21 INFO - https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:19:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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 08:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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 08:19:22 INFO - Downloaded 23176434 bytes. 08:19:22 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 08:19:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:19:22 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 08:19:23 INFO - Return code: 0 08:19:23 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')]} 08:19:23 INFO - https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:19:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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 08:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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 08:19:24 INFO - Downloaded 11132277 bytes. 08:19:24 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 08:19:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:24 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 08:19:24 INFO - Return code: 0 08:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:24 INFO - https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:19:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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 08:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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 08:19:26 INFO - Downloaded 54933684 bytes. 08:19:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:26 INFO - mkdir: /builds/slave/test-pgo/properties 08:19:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:19:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:19:26 INFO - Contents: 08:19:26 INFO - build_url:https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:19:26 INFO - Running post-action listener: _resource_record_post_action 08:19:26 INFO - Running post-action listener: set_extra_try_arguments 08:19:26 INFO - ##### 08:19:26 INFO - ##### Running populate-webroot step. 08:19:26 INFO - ##### 08:19:26 INFO - Running pre-action listener: _resource_record_pre_action 08:19:26 INFO - Running main action method: populate_webroot 08:19:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:26 INFO - '--tppagecycles', 08:19:26 INFO - '7'], 08:19:26 INFO - 'tests': ['tsvgm']}}, 08:19:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:19:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:19:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:19:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'tests': ['damp', 'tps']}, 08:19:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['damp', 'tps']}, 08:19:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:19:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:26 INFO - 'other': {'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other_l64': {'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other_nol64': {'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'svgr': {'tests': ['tsvgx', 08:19:26 INFO - 'tsvgr_opacity', 08:19:26 INFO - 'tart', 08:19:26 INFO - 'tscrollx', 08:19:26 INFO - 'cart']}, 08:19:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['tsvgx', 08:19:26 INFO - 'tsvgr_opacity', 08:19:26 INFO - 'tart', 08:19:26 INFO - 'tscrollx', 08:19:26 INFO - 'cart']}, 08:19:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'tests': ['tp5o']}, 08:19:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['tp5o']}, 08:19:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--xperf_path', 08:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:26 INFO - 'tests': ['tp5n']}, 08:19:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--e10s', 08:19:26 INFO - '--xperf_path', 08:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:26 INFO - 'tests': ['tp5n']}}, 08:19:26 INFO - 'talos.zip': {'path': '', 08:19:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:26 INFO - Running post-action listener: _resource_record_post_action 08:19:26 INFO - ##### 08:19:26 INFO - ##### Running create-virtualenv step. 08:19:26 INFO - ##### 08:19:26 INFO - Running pre-action listener: _resource_record_pre_action 08:19:26 INFO - Running main action method: create_virtualenv 08:19:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:19:26 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 08:19:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:19:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:26 INFO - Using real prefix '/usr' 08:19:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:19:26 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:28 INFO - Installing pip.................done. 08:19:28 INFO - Return code: 0 08:19:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:19:28 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')]} 08:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:28 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')]} 08:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:28 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:28 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 08:19:28 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 08:19:28 INFO - Using env: {'DISPLAY': ':0', 08:19:28 INFO - 'HOME': '/home/cltbld', 08:19:28 INFO - 'LANG': 'en_US.UTF-8', 08:19:28 INFO - 'LANGUAGE': 'en_US:en', 08:19:28 INFO - 'LOGNAME': 'cltbld', 08:19:28 INFO - 'MAIL': '/var/mail/cltbld', 08:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:28 INFO - 'MOZ_NO_REMOTE': '1', 08:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:28 INFO - 'NO_EM_RESTART': '1', 08:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:28 INFO - 'SHELL': '/bin/bash', 08:19:28 INFO - 'SHLVL': '1', 08:19:28 INFO - 'TERM': 'linux', 08:19:28 INFO - 'TMOUT': '86400', 08:19:28 INFO - 'USER': 'cltbld', 08:19:28 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:28 INFO - '_': '/tools/buildbot/bin/python'} 08:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:29 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 08:19:29 INFO - Cleaning up... 08:19:29 INFO - Return code: 0 08:19:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:29 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:29 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 08:19:29 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 08:19:29 INFO - Using env: {'DISPLAY': ':0', 08:19:29 INFO - 'HOME': '/home/cltbld', 08:19:29 INFO - 'LANG': 'en_US.UTF-8', 08:19:29 INFO - 'LANGUAGE': 'en_US:en', 08:19:29 INFO - 'LOGNAME': 'cltbld', 08:19:29 INFO - 'MAIL': '/var/mail/cltbld', 08:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:29 INFO - 'MOZ_NO_REMOTE': '1', 08:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:29 INFO - 'NO_EM_RESTART': '1', 08:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:29 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:29 INFO - 'SHELL': '/bin/bash', 08:19:29 INFO - 'SHLVL': '1', 08:19:29 INFO - 'TERM': 'linux', 08:19:29 INFO - 'TMOUT': '86400', 08:19:29 INFO - 'USER': 'cltbld', 08:19:29 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:29 INFO - '_': '/tools/buildbot/bin/python'} 08:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:29 INFO - Downloading/unpacking psutil>=0.7.1 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:29 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 08:19:30 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:19:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:19:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:31 INFO - Installing collected packages: psutil 08:19:31 INFO - Running setup.py install for psutil 08:19:31 INFO - building 'psutil._psutil_linux' extension 08:19:31 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 08:19:31 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 08:19:31 INFO - building 'psutil._psutil_posix' extension 08:19:31 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 08:19:31 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 08:19:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:31 INFO - Successfully installed psutil 08:19:31 INFO - Cleaning up... 08:19:31 INFO - Return code: 0 08:19:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:31 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:31 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 08:19:31 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 08:19:31 INFO - Using env: {'DISPLAY': ':0', 08:19:31 INFO - 'HOME': '/home/cltbld', 08:19:31 INFO - 'LANG': 'en_US.UTF-8', 08:19:31 INFO - 'LANGUAGE': 'en_US:en', 08:19:31 INFO - 'LOGNAME': 'cltbld', 08:19:31 INFO - 'MAIL': '/var/mail/cltbld', 08:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:31 INFO - 'MOZ_NO_REMOTE': '1', 08:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:31 INFO - 'NO_EM_RESTART': '1', 08:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:31 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:31 INFO - 'SHELL': '/bin/bash', 08:19:31 INFO - 'SHLVL': '1', 08:19:31 INFO - 'TERM': 'linux', 08:19:31 INFO - 'TMOUT': '86400', 08:19:31 INFO - 'USER': 'cltbld', 08:19:31 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:31 INFO - '_': '/tools/buildbot/bin/python'} 08:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:19:31 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 08:19:31 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 08:19:31 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 08:19:31 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 08:19:31 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 08:19:31 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 08:19:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:19:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:19:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:19:33 INFO - Installing collected packages: mozsystemmonitor 08:19:33 INFO - Running setup.py install for mozsystemmonitor 08:19:33 INFO - Successfully installed mozsystemmonitor 08:19:33 INFO - Cleaning up... 08:19:33 INFO - Return code: 0 08:19:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:33 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:33 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 08:19:33 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 08:19:33 INFO - Using env: {'DISPLAY': ':0', 08:19:33 INFO - 'HOME': '/home/cltbld', 08:19:33 INFO - 'LANG': 'en_US.UTF-8', 08:19:33 INFO - 'LANGUAGE': 'en_US:en', 08:19:33 INFO - 'LOGNAME': 'cltbld', 08:19:33 INFO - 'MAIL': '/var/mail/cltbld', 08:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:33 INFO - 'MOZ_NO_REMOTE': '1', 08:19:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:33 INFO - 'NO_EM_RESTART': '1', 08:19:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:33 INFO - 'SHELL': '/bin/bash', 08:19:33 INFO - 'SHLVL': '1', 08:19:33 INFO - 'TERM': 'linux', 08:19:33 INFO - 'TMOUT': '86400', 08:19:33 INFO - 'USER': 'cltbld', 08:19:33 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:33 INFO - '_': '/tools/buildbot/bin/python'} 08:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:33 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 08:19:33 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 08:19:33 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 08:19:33 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 08:19:33 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 08:19:33 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 08:19:35 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:19:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:35 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 08:19:35 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 08:19:35 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 08:19:35 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 08:19:35 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 08:19:35 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 08:19:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:19:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:19:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:36 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 08:19:36 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 08:19:36 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 08:19:36 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 08:19:36 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 08:19:36 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 08:19:36 INFO - Downloading docopt-0.6.1.tar.gz 08:19:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:19:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:36 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:36 INFO - Running setup.py install for blobuploader 08:19:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:19:36 INFO - Running setup.py install for requests 08:19:36 INFO - Running setup.py install for docopt 08:19:36 INFO - Successfully installed blobuploader requests docopt 08:19:36 INFO - Cleaning up... 08:19:36 INFO - Return code: 0 08:19:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:36 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')]} 08:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:36 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')]} 08:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:36 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:36 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 08:19:36 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 08:19:36 INFO - Using env: {'DISPLAY': ':0', 08:19:36 INFO - 'HOME': '/home/cltbld', 08:19:36 INFO - 'LANG': 'en_US.UTF-8', 08:19:36 INFO - 'LANGUAGE': 'en_US:en', 08:19:36 INFO - 'LOGNAME': 'cltbld', 08:19:36 INFO - 'MAIL': '/var/mail/cltbld', 08:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:36 INFO - 'MOZ_NO_REMOTE': '1', 08:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:36 INFO - 'NO_EM_RESTART': '1', 08:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:36 INFO - 'SHELL': '/bin/bash', 08:19:36 INFO - 'SHLVL': '1', 08:19:36 INFO - 'TERM': 'linux', 08:19:36 INFO - 'TMOUT': '86400', 08:19:36 INFO - 'USER': 'cltbld', 08:19:36 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:36 INFO - '_': '/tools/buildbot/bin/python'} 08:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:37 INFO - Running setup.py (path:/tmp/pip-uuxz8B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:37 INFO - Running setup.py (path:/tmp/pip-SjVWcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:37 INFO - Running setup.py (path:/tmp/pip-5fPjEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:37 INFO - Running setup.py (path:/tmp/pip-Hp7fVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:37 INFO - Running setup.py (path:/tmp/pip-UJWiqe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:37 INFO - Running setup.py (path:/tmp/pip-Qd4nGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:37 INFO - Running setup.py (path:/tmp/pip-x0DmXa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:37 INFO - Running setup.py (path:/tmp/pip-YYZDSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:37 INFO - Running setup.py (path:/tmp/pip-YaMcV9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:37 INFO - Running setup.py (path:/tmp/pip-ipbISu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:37 INFO - Running setup.py (path:/tmp/pip-UKyyDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:37 INFO - Running setup.py (path:/tmp/pip-d_7an2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:37 INFO - Running setup.py (path:/tmp/pip-xAquyE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:38 INFO - Running setup.py (path:/tmp/pip-gaA8Sm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:38 INFO - Running setup.py (path:/tmp/pip-_Dr8VW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:38 INFO - Running setup.py (path:/tmp/pip-lPPr9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:38 INFO - Running setup.py (path:/tmp/pip-Wml6sF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:38 INFO - Running setup.py install for manifestparser 08:19:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:19:38 INFO - Running setup.py install for mozcrash 08:19:38 INFO - Running setup.py install for mozdebug 08:19:38 INFO - Running setup.py install for mozdevice 08:19:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:19:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:19:38 INFO - Running setup.py install for mozfile 08:19:38 INFO - Running setup.py install for mozhttpd 08:19:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:19:38 INFO - Running setup.py install for mozinfo 08:19:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Running setup.py install for mozInstall 08:19:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Running setup.py install for mozleak 08:19:39 INFO - Running setup.py install for mozlog 08:19:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Running setup.py install for moznetwork 08:19:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Running setup.py install for mozprocess 08:19:39 INFO - Running setup.py install for mozprofile 08:19:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Running setup.py install for mozrunner 08:19:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:19:39 INFO - Running setup.py install for mozscreenshot 08:19:39 INFO - Running setup.py install for moztest 08:19:39 INFO - Running setup.py install for mozversion 08:19:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:19:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:40 INFO - Cleaning up... 08:19:40 INFO - Return code: 0 08:19:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:40 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 08:19:40 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 08:19:40 INFO - Using env: {'DISPLAY': ':0', 08:19:40 INFO - 'HOME': '/home/cltbld', 08:19:40 INFO - 'LANG': 'en_US.UTF-8', 08:19:40 INFO - 'LANGUAGE': 'en_US:en', 08:19:40 INFO - 'LOGNAME': 'cltbld', 08:19:40 INFO - 'MAIL': '/var/mail/cltbld', 08:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:40 INFO - 'MOZ_NO_REMOTE': '1', 08:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:40 INFO - 'NO_EM_RESTART': '1', 08:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:40 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:40 INFO - 'SHELL': '/bin/bash', 08:19:40 INFO - 'SHLVL': '1', 08:19:40 INFO - 'TERM': 'linux', 08:19:40 INFO - 'TMOUT': '86400', 08:19:40 INFO - 'USER': 'cltbld', 08:19:40 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:40 INFO - '_': '/tools/buildbot/bin/python'} 08:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:40 INFO - Running setup.py (path:/tmp/pip-R0omlk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:40 INFO - Running setup.py (path:/tmp/pip-qJdHQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:40 INFO - Running setup.py (path:/tmp/pip-os6rTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:40 INFO - Running setup.py (path:/tmp/pip-gg85bB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:40 INFO - Running setup.py (path:/tmp/pip-yJPYYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:40 INFO - Running setup.py (path:/tmp/pip-XQ_RED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:40 INFO - Running setup.py (path:/tmp/pip-tQFOx3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:40 INFO - Running setup.py (path:/tmp/pip-9OQT5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:40 INFO - Running setup.py (path:/tmp/pip-oZ2Wxv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:40 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)) 08:19:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:40 INFO - Running setup.py (path:/tmp/pip-07h0Gu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:41 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)) 08:19:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:41 INFO - Running setup.py (path:/tmp/pip-vSpvLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:41 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)) 08:19:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:41 INFO - Running setup.py (path:/tmp/pip-DOImnC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:41 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)) 08:19:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:41 INFO - Running setup.py (path:/tmp/pip-DjlriV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:41 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)) 08:19:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:41 INFO - Running setup.py (path:/tmp/pip-GUGtF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:41 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)) 08:19:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:41 INFO - Running setup.py (path:/tmp/pip-n50QfK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:41 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)) 08:19:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:41 INFO - Running setup.py (path:/tmp/pip-LIL6Z0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:41 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)) 08:19:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:41 INFO - Running setup.py (path:/tmp/pip-PTLRVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:41 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)) 08:19:41 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)) 08:19:41 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)) 08:19:41 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)) 08:19:41 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)) 08:19:41 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)) 08:19:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:41 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 08:19:41 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 08:19:41 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 08:19:41 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 08:19:41 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 08:19:41 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 08:19:43 INFO - Downloading blessings-1.5.1.tar.gz 08:19:43 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 08:19:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:43 INFO - Installing collected packages: blessings 08:19:43 INFO - Running setup.py install for blessings 08:19:43 INFO - Successfully installed blessings 08:19:43 INFO - Cleaning up... 08:19:43 INFO - Return code: 0 08:19:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:19:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:19:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:19:43 INFO - Reading from file tmpfile_stdout 08:19:43 INFO - Current package versions: 08:19:43 INFO - argparse == 1.2.1 08:19:43 INFO - blessings == 1.5.1 08:19:43 INFO - blobuploader == 1.2.4 08:19:43 INFO - docopt == 0.6.1 08:19:43 INFO - manifestparser == 1.1 08:19:43 INFO - mozInstall == 1.12 08:19:43 INFO - mozcrash == 0.16 08:19:43 INFO - mozdebug == 0.1 08:19:43 INFO - mozdevice == 0.47 08:19:43 INFO - mozfile == 1.2 08:19:43 INFO - mozhttpd == 0.7 08:19:43 INFO - mozinfo == 0.9 08:19:43 INFO - mozleak == 0.1 08:19:43 INFO - mozlog == 3.1 08:19:43 INFO - moznetwork == 0.27 08:19:43 INFO - mozprocess == 0.22 08:19:43 INFO - mozprofile == 0.28 08:19:43 INFO - mozrunner == 6.11 08:19:43 INFO - mozscreenshot == 0.1 08:19:43 INFO - mozsystemmonitor == 0.0 08:19:43 INFO - moztest == 0.7 08:19:43 INFO - mozversion == 1.4 08:19:43 INFO - psutil == 3.1.1 08:19:43 INFO - requests == 1.2.3 08:19:43 INFO - wsgiref == 0.1.2 08:19:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:43 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:43 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 08:19:43 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 08:19:43 INFO - Using env: {'DISPLAY': ':0', 08:19:43 INFO - 'HOME': '/home/cltbld', 08:19:43 INFO - 'LANG': 'en_US.UTF-8', 08:19:43 INFO - 'LANGUAGE': 'en_US:en', 08:19:43 INFO - 'LOGNAME': 'cltbld', 08:19:43 INFO - 'MAIL': '/var/mail/cltbld', 08:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:43 INFO - 'MOZ_NO_REMOTE': '1', 08:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:43 INFO - 'NO_EM_RESTART': '1', 08:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:43 INFO - 'SHELL': '/bin/bash', 08:19:43 INFO - 'SHLVL': '1', 08:19:43 INFO - 'TERM': 'linux', 08:19:43 INFO - 'TMOUT': '86400', 08:19:43 INFO - 'USER': 'cltbld', 08:19:43 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:43 INFO - '_': '/tools/buildbot/bin/python'} 08:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 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)) 08:19:43 INFO - Cleaning up... 08:19:43 INFO - Return code: 0 08:19:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:43 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:43 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 08:19:43 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 08:19:43 INFO - Using env: {'DISPLAY': ':0', 08:19:43 INFO - 'HOME': '/home/cltbld', 08:19:43 INFO - 'LANG': 'en_US.UTF-8', 08:19:43 INFO - 'LANGUAGE': 'en_US:en', 08:19:43 INFO - 'LOGNAME': 'cltbld', 08:19:43 INFO - 'MAIL': '/var/mail/cltbld', 08:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:43 INFO - 'MOZ_NO_REMOTE': '1', 08:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:43 INFO - 'NO_EM_RESTART': '1', 08:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:43 INFO - 'SHELL': '/bin/bash', 08:19:43 INFO - 'SHLVL': '1', 08:19:43 INFO - 'TERM': 'linux', 08:19:43 INFO - 'TMOUT': '86400', 08:19:43 INFO - 'USER': 'cltbld', 08:19:43 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:43 INFO - '_': '/tools/buildbot/bin/python'} 08:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:44 INFO - Downloading/unpacking jsonschema 08:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:45 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 08:19:45 INFO - Downloading/unpacking functools32 (from jsonschema) 08:19:45 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 08:19:45 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 08:19:45 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 08:19:45 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 08:19:45 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 08:19:45 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 08:19:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:19:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:46 INFO - warning: no files found matching '*.txt' 08:19:46 INFO - no previously-included directories found matching 'build' 08:19:46 INFO - no previously-included directories found matching 'dist' 08:19:46 INFO - no previously-included directories found matching '.git*' 08:19:46 INFO - Installing collected packages: jsonschema, functools32 08:19:46 INFO - Running setup.py install for functools32 08:19:46 INFO - warning: no files found matching '*.txt' 08:19:46 INFO - no previously-included directories found matching 'build' 08:19:46 INFO - no previously-included directories found matching 'dist' 08:19:46 INFO - no previously-included directories found matching '.git*' 08:19:46 INFO - Successfully installed jsonschema functools32 08:19:46 INFO - Cleaning up... 08:19:46 INFO - Return code: 0 08:19:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:19:46 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')]} 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:46 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')]} 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:46 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 0x7fbac004af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c25630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, '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': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', '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 08:19:46 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 08:19:46 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 08:19:46 INFO - Using env: {'DISPLAY': ':0', 08:19:46 INFO - 'HOME': '/home/cltbld', 08:19:46 INFO - 'LANG': 'en_US.UTF-8', 08:19:46 INFO - 'LANGUAGE': 'en_US:en', 08:19:46 INFO - 'LOGNAME': 'cltbld', 08:19:46 INFO - 'MAIL': '/var/mail/cltbld', 08:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:46 INFO - 'MOZ_NO_REMOTE': '1', 08:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:46 INFO - 'NO_EM_RESTART': '1', 08:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:46 INFO - 'SHELL': '/bin/bash', 08:19:46 INFO - 'SHLVL': '1', 08:19:46 INFO - 'TERM': 'linux', 08:19:46 INFO - 'TMOUT': '86400', 08:19:46 INFO - 'USER': 'cltbld', 08:19:46 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:46 INFO - '_': '/tools/buildbot/bin/python'} 08:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:46 INFO - Downloading/unpacking flake8 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:19:48 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 08:19:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:19:48 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 08:19:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 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 08:19:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:19:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:19:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:48 INFO - no previously-included directories found matching 'docs/_build' 08:19:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:19:48 INFO - Running setup.py install for pep8 08:19:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:49 INFO - no previously-included directories found matching 'docs/_build' 08:19:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:19:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:19:49 INFO - Cleaning up... 08:19:49 INFO - Return code: 0 08:19:49 INFO - Running post-action listener: _resource_record_post_action 08:19:49 INFO - Running post-action listener: _start_resource_monitoring 08:19:49 INFO - Starting resource monitoring. 08:19:49 INFO - ##### 08:19:49 INFO - ##### Running install step. 08:19:49 INFO - ##### 08:19:49 INFO - Running pre-action listener: _resource_record_pre_action 08:19:49 INFO - Running main action method: install 08:19:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:19:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:19:49 INFO - Reading from file tmpfile_stdout 08:19:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:19:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:19:49 INFO - Reading from file tmpfile_stdout 08:19:49 INFO - Output received: 08:19:49 INFO - Usage: mozinstall [options] installer 08:19:49 INFO - Options: 08:19:49 INFO - -h, --help show this help message and exit 08:19:49 INFO - -d DEST, --destination=DEST 08:19:49 INFO - Directory to install application into. [default: 08:19:49 INFO - "/builds/slave/test-pgo"] 08:19:49 INFO - --app=APP Application being installed. [default: firefox] 08:19:49 INFO - mkdir: /builds/slave/test-pgo/build/application 08:19:49 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'] 08:19:49 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 08:20:05 INFO - Reading from file tmpfile_stdout 08:20:05 INFO - Output received: 08:20:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:20:05 INFO - Running post-action listener: _resource_record_post_action 08:20:05 INFO - ##### 08:20:05 INFO - ##### Running run-tests step. 08:20:05 INFO - ##### 08:20:05 INFO - Running pre-action listener: _resource_record_pre_action 08:20:05 INFO - Running main action method: run_tests 08:20:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:20:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:20:05 INFO - Python 2.7.3 08:20:05 INFO - Return code: 0 08:20:05 INFO - grabbing minidump binary from tooltool 08:20: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')]} 08:20:05 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 0x1cb6840>, '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 0x1c236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c23b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:20:05 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 08:20:05 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 08:20:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:20:05 INFO - Return code: 0 08:20:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:20:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:20:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:20:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:20:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:20:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:20:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:20:06 INFO - Return code: 0 08:20:06 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/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 08:20:06 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/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 08:20:06 INFO - Using env: {'DISPLAY': ':0', 08:20:06 INFO - 'HOME': '/home/cltbld', 08:20:06 INFO - 'LANG': 'en_US.UTF-8', 08:20:06 INFO - 'LANGUAGE': 'en_US:en', 08:20:06 INFO - 'LOGNAME': 'cltbld', 08:20:06 INFO - 'MAIL': '/var/mail/cltbld', 08:20:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:20:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:06 INFO - 'MOZ_NO_REMOTE': '1', 08:20:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:06 INFO - 'NO_EM_RESTART': '1', 08:20:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:20:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:20:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:20:06 INFO - 'SHELL': '/bin/bash', 08:20:06 INFO - 'SHLVL': '1', 08:20:06 INFO - 'TERM': 'linux', 08:20:06 INFO - 'TMOUT': '86400', 08:20:06 INFO - 'USER': 'cltbld', 08:20:06 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450714755.907910-840275645', 08:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:06 INFO - '_': '/tools/buildbot/bin/python'} 08:20:06 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/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 08:20:06 INFO - mozversion application_buildid: 20151221053036 08:20:06 INFO - mozversion application_changeset: 12019f25b95191d629f5b605f894b0d0f22b1e37 08:20:06 INFO - mozversion application_display_name: Nightly 08:20:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:20:06 INFO - mozversion application_name: Firefox 08:20:06 INFO - mozversion application_remotingname: firefox 08:20:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:20:06 INFO - mozversion application_vendor: Mozilla 08:20:06 INFO - mozversion application_version: 46.0a1 08:20:06 INFO - mozversion platform_buildid: 20151221053036 08:20:06 INFO - mozversion platform_changeset: 12019f25b95191d629f5b605f894b0d0f22b1e37 08:20:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:20:06 INFO - mozversion platform_version: 46.0a1 08:20:06 INFO - using testdate: 1450714806 08:20:06 INFO - actual date: 1450714806 08:20:06 INFO - starting webserver on 'localhost:49729' 08:20:06 INFO - SUITE-START | Running 3 tests 08:20:06 INFO - TEST-START | dromaeo_css 08:20:06 INFO - operating with platform_type : linux_ 08:20:06 INFO - Initialising browser for dromaeo_css test... 08:20:06 INFO - TEST-INFO | started process 8543 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpphPSrT/profile http://localhost:49729/getInfo.html) 08:20:10 INFO - PROCESS | 8543 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 08:20:11 INFO - PROCESS | 8543 | __metrics Screen width/height:1600/1200 08:20:11 INFO - PROCESS | 8543 | colorDepth:24 08:20:11 INFO - PROCESS | 8543 | Browser inner width/height: 1024/697 08:20:11 INFO - PROCESS | 8543 | __metrics 08:20:11 INFO - PROCESS | 8543 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:20:12 INFO - TEST-INFO | 8543: exit 0 08:20:12 INFO - Browser initialized. 08:20:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:20:12 INFO - TEST-INFO | started process 8677 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpphPSrT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:23 INFO - PROCESS | 8677 | RSS: Main: 150499328 08:20:23 INFO - PROCESS | 8677 | 08:21:13 INFO - PROCESS | 8677 | 1450714873421 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] 08:23:22 INFO - PROCESS | 8677 | Cycle 1(1): loaded http://localhost:49729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49729/tests/dromaeo/cssquery-ext.html) 08:23:23 INFO - PROCESS | 8677 | RSS: Main: 157777920 08:23:23 INFO - PROCESS | 8677 | 08:26:25 INFO - PROCESS | 8677 | Cycle 1(1): loaded http://localhost:49729/tests/dromaeo/cssquery-ext.html (next: http://localhost:49729/tests/dromaeo/cssquery-jquery.html) 08:26:25 INFO - PROCESS | 8677 | RSS: Main: 154021888 08:26:25 INFO - PROCESS | 8677 | 08:29:27 INFO - PROCESS | 8677 | Cycle 1(1): loaded http://localhost:49729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49729/tests/dromaeo/cssquery-mootools.html) 08:29:28 INFO - PROCESS | 8677 | RSS: Main: 152653824 08:29:28 INFO - PROCESS | 8677 | 08:32:29 INFO - PROCESS | 8677 | Cycle 1(1): loaded http://localhost:49729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49729/tests/dromaeo/cssquery-prototype.html) 08:32:30 INFO - PROCESS | 8677 | RSS: Main: 152338432 08:32:30 INFO - PROCESS | 8677 | 08:35:32 INFO - PROCESS | 8677 | Cycle 1(1): loaded http://localhost:49729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49729/tests/dromaeo/cssquery-yui.html) 08:35:33 INFO - PROCESS | 8677 | RSS: Main: 152821760 08:35:33 INFO - PROCESS | 8677 | 08:38:35 INFO - PROCESS | 8677 | Cycle 1(1): loaded http://localhost:49729/tests/dromaeo/cssquery-yui.html (next: http://localhost:49729/tests/dromaeo/cssquery-dojo.html) 08:38:36 INFO - PROCESS | 8677 | RSS: Main: 154456064 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - PROCESS | 8677 | __start_tp_report 08:38:36 INFO - PROCESS | 8677 | _x_x_mozilla_page_load 08:38:36 INFO - PROCESS | 8677 | _x_x_mozilla_page_load_details 08:38:36 INFO - PROCESS | 8677 | |i|pagename|runs| 08:38:36 INFO - PROCESS | 8677 | |0;dojo.html;3168.6989735975085;3225.1130938991773;3251.64231934487;3274.770766046376;3283.261266215102;5191.948080519203;5398.91901621476;5432.076546987012;5451.182322651604;5467.972660136698;5293;5382.273393091931;5388.137897936331;5391.946080539194;5440.972795136019;4642.141203877277;4874.8537543873745;5023.3971923369245;5036.6222533309965;5042.647014708972;4804.087223427555;4958.578520825734;4978.701277923318;5013.498650134994;5039.269305950635;4841.878953026185;4872.6345524085655;4887.169181239198;4905.2151655734915;4954.083494553519;4839.225723884161;4861.465238823726;4863.8297659582095;4871.464138944713;4917;4729.55069268419;4813.109574728686;4861.100696371147;4862.41651001882;4897.069556784235;5091.87270318245;5116.309298244763;5151.562117220041;5160.793568257265;5232.1628539433505;5778.930897783924;5826.242588463515;5830;5832.2418085649015;5881.823545293648;5719.7140142992685;5822.359540450547;5871.060630299132;5885.205497257858;5922.200502932092;5405.108157154064;5426.348838139448;5430.6741595504;5442.020436321461;5444.40111587725;5931.881362372728;6014.428629280299;6015.127806468037;6015.729292181863;6020.307664618537;5714.200011998323;5758.049921762862;5760.337561180434;5790.913136302959;5791.855203619859;5716.942830571641;5793.420657934173;5825;5854.2096816930025;5859.677717725566;5821.912671309934;5830.679312637845;5832.416758324219;5853.443922827325;5893.027650437715;5761.942380576224;5789.681567513827;5851.941480585139;5859.53123750099;5873.794417195378;4383.49589797171;4403.625691816167;4424.137293227854;4468.821247150077;4503.954960450419;3995.600439955981;3999.8200080996426;4003.399490076512;4013.3779264214095;4057.6753859691153;5591.692456914828;5610.523105535994;5612.466815652507;5613.522850557667;5616.9157462638095;5671.829845104653;5770.221020162225;5850.151727999501;5893.6463812171405;5958.1062840573395;5536.612437129363;5545.1682247663175;5569.66582005081;5572.192032155314;5601.187827764951;4961.479044700327;5070;5076.974615126901;5079.034983353151;5121.1550094234035;5952;5960.165576819162;6033.698315084141;6033.939660603338;6085.269767627913;5775.826725198251;5848.210491583582;5850.12248162779;5856.824295271149;5887.381824908494;5827.358990511125;5894.705264736832;5948.821535353946;6014.308354539284;6017.699115044318;5642.463965923231;5757;5759.424057594207;5773.422657734193;5797.913031304618;5811.360750317377;5830.82507524775;5851.678157701197;5866.208061911588;5875.3243377010485;5489.725513724377;5596.18855265976;5647.85880352978;5670.716464176692;5684.573656975661;5721.170430287668;5780.21967034445;5791.102379131242;5799.594028418139;5829.213056237354;5586.553075753849;5621.184928185308;5636.464535869086;5637.43625637433;5649.717514124195;5505.339359276913;5541.251930989426;5649.576281778801;5715.799947001835;5745.2818397700285;5649.378568357395;5655.604107712421;5660;5664.830055098354;5665.036943719495 08:38:36 INFO - PROCESS | 8677 | |1;ext.html;561.9129034999573;609.0833295889686;610.1092405088572;616.3805375597525;622.9626222426657;35201.47197792032;35862.64137358626;35864.46203306949;35876.28247435056;36068.45897311539;40988;41341.7932910335;41453.17093658125;41488.58511414885;41489.58510414895;8751.29989600832;8895.066018068106;8974.102589741038;8981.281497480186;8992;8663.350248731338;8802.691905783267;8829.381943263974;8838.602262898154;8846.424982376157;8548.145185481464;8559.443636163629;8564.443311184785;8589.441686290402;8619.525926074064;8699.782505437352;8818.955905220464;8826.64693412266;8828.249598784047;8850.20348168668;8544.273736732384;8605.95697021511;8706.347023973227;8719.520426376546;8728.170823771732;38989.220215595815;39550.60449395527;39608;39615.60384396148;39730.404043939365;3015.457217700813;3034.6055012848187;3034.9393012139635;3081.029475715143;3115.376924615063;29193.906285759742;29567.852160739272;30030;30206;30621.387572248652;3590.8025058621765;3610.981945090258;3611.927761444783;3721.441783732435;3750.268697603968;265448.6727566369;265943;266678;266821;267583;48689.5131048685;49869.50130498649;55980;56363.71818140883;63795;57614;57650;58465;58541;58672;15275.312610932535;15585.142817144939;15617.219139043229;15742.842571574138;15767.921160394355;12160.513579456723;12219.450124744408;12269.754604907852;12428.937855310665;12453.816887395684;19455.610887782448;19655;19765.40703778889;19789.4063178102;19842;7676;7804;7858.528488290721;7942.722004729807;7945.887575739401;929.3819609959302;970.7621632700034;989.2382865193761;1015.669907280137;1021.7139201023725;26641.33396665099;27149.864250679017;27612.861935690195;27620.58569121465;27620.723792762215;928.7863791327898;941.228192881844;994.3735446668552;994.6369575105034;1070.4968664727567;13255.801162982563;13502.32488375597;13746.106503077268;13747.450101996008;13914.791278130837;314214;317490;318428;319796;320276;49801.50198497969;50023.24965125453;50288.49711502838;50477.24284135741;50509.747451262505;1299.3698056442618;1317.0188209783773;1321.8281623389091;1354.5326862232712;1372.073850151144;25387.873060634578;26594.33514162084;26658.733412666403;26800.731992679823;26887;44844.32733508935;44944.55055449404;44996.55003449923;45092;45150.32274515951;295576;296648;298312;298999;299047;30815.2296192597;31132;31445.685543144275;31515.36969260556;31552;36929.63070369262;38224.23551529009;38344;38971.805140975244;41153.176936460506;33644.66355336415;33996.32007359889;34633.826830865684;34978.30043399067;35061.370397220824;34615.307693845476;35737.821310893276;35951.64048359483;36004;36456.81771591125;31879;32229.838850806533;32467.837660811543;32553.186170345933;32678.34643307168;29547.704522954496;31194.22014449657;31986.52020219745;32012.51981220237;32046.795320467765;22519.09923603103;22668.65997010079;23328.53342933166;23437.296881093593;25488.490230195664 08:38:36 INFO - PROCESS | 8677 | |2;jquery.html;355.82208895552225;355.84342889128766;355.893232030391;356.85547353321897;359.88483685220734;16278.593035174112;17096.401625943094;17832.1975511102;17920.283188672438;18433.90783046083;11154.944225278883;11196.608118715847;11397.316161030323;11540.59607913721;11555.595554155607;4779.35478710374;4811.566958973692;4913.680610760307;4916.262560615901;4945.678530895499;4850.514948505156;4914.04176185644;4926.0394223126505;4939.654224204307;4960.553550180483;4877.26840973855;4896.045271172123;5175.5600773934075;5327.946720532803;5356.276902618155;5247.632665713401;5249.501297376743;5270.420253772082;5319.441458646845;6071.150038994544;5306.628536002481;5356.866078348034;5376.11294136467;5387.326584176978;5391.353037635469;11645.94177029118;12272;18373.081345932784;19727.309544165884;19893.303734369227;2072.492239401341;2097.4441772930186;2162.0703097667997;2185.3334732906455;2240.7535171131162;9357.157855793012;9640.71077867665;9867.40795552269;10002.399856008662;12527.93736031314;1865.5149661088215;1876.1088482970615;1877.4339412168981;1880.8495320374336;1893.5360836594984;57203;57850;57854.42145578575;58920.705396473175;59094.70452647752;9795;9803.460809655537;9854;9902.356346837432;9906.60373585063;12736.936315318364;12764.361781910868;12812.295323757096;12812.42344094518;12863.035272354611;7438.033055702724;7497.475176737576;7516.812079698051;7534.736284230025;7681.193474685189;7156.928430715626;7209.927900720925;7228.132624085143;7256.927430725731;7269.600171990592;4088.7546747195265;4182.602652747984;4242.85150019754;4296.183725092223;4353.804078816461;1796.2814874050484;1798.8111248319;1815.7004094324552;1829.890206587609;1849.7502837116817;913.3150137396952;914.6707185413246;974.3423189347162;999.4602914426274;1020.5152552537634;16040.919795400949;16189.19054047293;16284.674306513803;16546.255418506196;16583.253753581117;912.9680461183826;917.1791246834047;924.1082355526814;959.9232061435068;960.9519524023771;9382.390144640576;9778.339713180541;10028.19492491344;10079.244056695778;10123.1901447884;559092;564381;581579;582130;584316;43201.56798431976;43772.78113609475;44004.55995440068;77492;77869.61065194638;1149.4654985431814;1157.4444266752007;1162.9011534019535;1169.473736818435;1181.5982565927625;15690.372385104469;16219.270132843814;16347.100909450095;16353.100579468244;16464.506064818073;34715.65284347225;35262.823685881405;35909;36059.81970090133;36130.4580431299;43380.915477113325;44205.11589768251;44445.55554444414;44901.32648010217;45895.541044589125;9280.814383712423;9342;9632;9727.270454716067;9741.220702343653;11467.713307167387;11526.711832204262;15919.68160636804;16754.581135471224;17135.14324283756;13732.86267137316;13803.723925521634;13958.860411395755;14016.439342426189;14668;13753.312334383441;13793.517226897011;13977.301134943416;14211.857881421054;14606.196659183846;13896.16623002623;13909.165450073027;14168.008239423141;15062.096274223144;15080.472183473526;9150.542472876197;9578.185854202471;9733;9749.268804839523;9824.214062875095;12795.93602031984;13395.464181433023;13929.791053134008;14052.789208161681;14608.269586520844 08:38:36 INFO - PROCESS | 8677 | |3;mootools.html;1494.0438119603448;1717.3216579451114;1770.3449723602268;1770.6724256012635;1776.8400843924044;6725.730970761164;6903.275156108612;7197.352238298552;7746.53520788753;7761.6507257173425;7275.781726548212;7402.074740657418;7478.850422991537;7530;7536.623168841564;2247.2584047264363;2279.2592407467555;2283.098176220392;2288.0390236100793;2291.8968646410867;2245.5059886824874;2300.769923007694;2301.9079236830507;2312.8265380096477;2328.9534209315802;2297.6668383084443;2304.8040916522114;2340.262817212581;2350.6003979323555;2351.8588884666888;2272.4659704969404;2281.954360912781;2287.7712228777154;2293.86236825791;2303.2284184798114;2351.412146963259;2351.741308456086;2368.7631236876173;2377.09670325277;2377.465070359173;7487.363574096208;7567.2054434284155;7584.962075189644;7606.695732170707;7615;4565.4749703784155;4619.353290539327;4621.168189725848;4636.79134438951;4664.277037059262;2964.081134848204;2973.2120987938215;3010.864511097006;3025.803322784012;3055.724984751361;993.64228877604;994.3089552760835;1751.9299228030864;1754.6052138268915;1780.1455301455374;10131.088202061776;10210.795784084277;10217.693469195936;10219.233557483145;10241.84637230442;4138.730982486129;4192.769397683096;4268.16770729711;4281.785910704452;4306.41863348444;8449.070602233749;8457.154284571616;8460.830783384297;8462.534560599102;8475.321974242046;4647.814087436464;4700.670953033255;4706.717596944194;4715.882102947454;4726.810927562928;4291.763952982554;4325.870223893288;4326.069894972596;4354.412154359121;4369.47566292047;3544.6455354464865;3551.8046507441823;3569.94645080324;3606.062423769839;3661.2860492204295;1050.3802756373775;1052.3633201912885;1055.055725126008;1093.9398333091597;1116.8827273136367;1324.635725175565;1327.323065236717;1337.531863847665;1355.2884735513935;1364.0587994283912;7153.034340364088;7156.141263048467;7321.890171647429;7334.3032411920785;7350.77947661571;1093.2729734726477;1094.715374002765;1097.314178638351;1100.763335882789;1117.6814607836727;5727.2268243787385;5748.971255143698;5795.797147099831;5803.158542011384;5820;8879.33404994615;8946.86579701305;9021.413608115452;9089.81820363589;9145.77135571616;9012.774680633036;9030.774230644287;9041.683541076163;9070.773230669154;9079.409838360485;6997.195322537871;7041.8239544010785;7083.433325333961;7111.111111111111;7174.210836807947;6917.13535808024;6936.20233673134;6938;6956.130483689539;6957.860842783217;7673.079230492377;8006.159353268056;8075.5558444286125;8081.4747041442115;8216.83566328682;8123.18768123183;8177.836443271221;8272.131426200162;8325.417220794487;8396.790080248044;5509.311336082989;6345.302016778059;6454.741810327534;6497;6545.14913061299;7188;7218.458615603956;7220.916862470672;7221.205667376479;7252.492325537372;6713.932860671331;6858.794236172923;6937.167539895245;6957;6974.895376569457;6765.898511522233;6808.897866531907;6870.27862074475;6952.7485052691;6964.686589103604;6715.395614394728;6721.059051732859;6865.210500792473;6902.620355880274;6927.099477067949;6307.936920630735;6315.905261421174;6347.5239357047485;6360.4911607072245;6366.267879193952;6514.250861151028;6522.315156908646;6528.67356632176;6540.018997150465;6544.411003009752 08:38:36 INFO - PROCESS | 8677 | |4;prototype.html;340.933517963997;351.6439852985001;353.5403974832717;356.07065558891287;360.04946940078185;6334.651594162319;6340.651264180468;6384.712687929037;6386.361363863612;6398.360163983611;6315.084312774645;6320.715567799449;6322.557420980534;6364.777232796853;6365.427111559959;4735.4080739907595;4770.21291486906;4776.522347765213;4777.570018698317;4778.044391121773;4778.737169455679;4780.737059461728;4780.737059461728;4781.235002399617;4786.712797232177;4645.69802962808;4725.763711814413;4726.196546587088;4733.124371991175;4735.9526404736025;4707.31743897133;4714.387129673138;4722.881927951795;4745.430548334222;4757.548032936866;4064.410660454247;4071;4072.9796351018354;4073.4500842386196;4075.633193012643;6011.338752737195;6038.728257228435;6041.909371359433;6045.425684559959;6063.696815159225;5349.384820745625;5492;5495.670259784426;5510.862228444281;5514.531264842453;6722.66386680664;6729.49528785343;6741.191057073133;6750.426213771835;6754;4481.619062379669;4491.393661855673;4495.168393847116;4503.639708823286;4509.842155524541;6891.138607674041;6989.126359205099;7049.259827718067;7067.646617669096;7077.186123595749;4716.127516409475;4737;4742.170120228946;4743.169945259566;4745.454272758677;4761.095391875532;4770.236762118045;4776.47458779534;4792.2811578262845;4810.7113573185725;5580.358258800209;5580.581456390787;5584.497395234367;5587.776488940397;5588.608797384144;6643.30245324234;6728.394444500019;6769.221539523018;6769.458443324522;6771.0182023607285;1625.959351016234;1649.991750041242;1659.120666046973;1663.9584010399838;1679.8908070975347;1125.0661950580998;1134.7617000430002;1136.2160109524402;1137.78382107401;1152.6657269391783;6298.433141017331;6410.1987251593555;6424.967875160594;6464.838379040468;6473.190851143607;6836.316368363124;6865.176178858569;6878.931210687929;6888.448924086061;6900.654967251618;6435.581687190318;6439.420452159328;6450.516211284079;6452.354764523604;6461.25695545009;3789.77261364319;3800.1259710266795;3822.8853134406013;3832.176082142297;3836.5971572984995;7273.963630181921;7298.452616053817;7320.084989376328;7334.559926404433;7348.338649521569;7004.334588214111;7141.107361579802;7189.0294810201;7193.460490463236;7231.602261875647;7287.161976372785;7295.489315747846;7297;7309.049823522908;7318.158411782607;6992.056072430157;7001.229864714979;7013.333733295329;7014.719411223698;7037.648117593997;6785.219699734396;6953.513254072166;6963.2340442552295;7004.0544526488275;7037.507374483737;7288.234735352712;7296.160941491797;7312.451566132668;7328.3770879473705;7337.523061001018;4738.312944622941;4739.312799644102;4766.856994290177;4771.618270538418;4776.259679749644;6834.384905358542;6888.793336199922;7058.082449281561;7067.187273463617;7071.646417679199;6802.557833740791;6804.11546498952;6815.829604259933;6822.181338239443;6824.044633751378;6742.157230346207;6818.318168183142;6821.454283657395;6822.249552549315;6830.624315662686;6503.089567460464;6664.7000884959325;6679.732810687518;6683;6697.866042679217;6773.424258938046;6822.692978816064;6823.044773731583;6825.317468253135;6835.521513494206;6607.405333520006;6631.966840165768;6648.468122550281;6649.0026496025985;6672.763709600937 08:38:36 INFO - PROCESS | 8677 | |5;yui.html;695.0512550368745;719.5610677486735;733.4132693844923;762.6186906546727;866.1165611076703;13302.401391937361;13645.658858528543;13646.727065458685;13662.453501859925;13708.383122759475;12819.294938778363;13001.154924929897;13020.804687929689;13543.796843047363;13570.457181712743;825.5088222507599;837.656560810068;837.9622916968721;840.0507426607925;840.277361469136;823.1685997142869;825.8513467575834;828.1015098617977;829.8298848735994;831.5634291996689;865.7878819689184;865.9004214515317;866.1338661338661;870.1211776106115;872.742540950418;859.166608389864;866.6403442571357;867.5748883047262;868.097178933908;869.4565896314804;630.4326106504183;632.705791806812;632.987340253197;635.4471609699544;636.9713362898681;11861.822072668916;11923.344216068113;11944;11981.580644677482;11993.520259189621;10560.313579617377;11092.500837462334;11160.497777600027;11165.38590377529;11225.943870280678;9745.951270243675;9797.951010244904;9868.013198680146;10191.439470829102;10360.740981475448;3474.2009337852182;3517.6482351764876;3522.119470132467;3533.593636731783;3790.9810450947843;43927.78036109831;44599.55400445987;44673;45173;45280.094398111854;9175.265978721687;9209.967471306305;9267.629294828132;9344.813103737888;9627.085426884434;18379.90810045968;18569;18587.34944276944;18627.254909803458;18631;7015.052967849377;7047.964760176166;7111.111111111111;7646.655900484491;7758.185390534026;4387.3857659927;4397.934030989538;4421.889452763642;4526.660500462479;4527.253003254426;3091.7990330628436;3106.968930310713;3108.9222769430944;3109.9067027989195;3126.968730312668;567.3730527766841;570.0309473894396;573.063041926445;574.9913751293734;580.7328628830785;488.5554145727442;555.7110302642684;628.4030171337248;680.9863802723918;693.9063226464464;8700;8837.91162088371;8863.423877448075;8896.955515222382;8992.685256016008;521.2702216896375;536.1849988018269;604.5254475236918;627.7489004398277;653.2552889705739;3800.5819359870393;3973.4834471518516;3987.1228329767405;4033.294173519681;4063.79681015948;58120.709396452745;58741;58776.41223587709;58847.70576147092;58899;55131.72434137804;57031.42968570344;57458.42541574531;57725.711371443715;58213.41786582165;45907;46938.29592556114;50910.74544627253;52506;52797.944041118964;8582.442141261048;8638.56807159652;8644.567771611268;8834.469931804113;8949.821003579762;36307.27385452329;36594.63405365912;37064.25871482609;37361.25277494489;37519.24961500809;42028;46782.298265525365;46799.53200467952;46852.531474684816;47057.76471117623;10218.284720069523;10224.284300098921;10244.795104098026;10701.197410194422;10855.728606784893;12096.274223546263;12273.518425239234;12430.254184748583;12534;12602.936985315382;11030.227884048361;11436.599719009795;11647.708807279885;11662.94168529152;11834.11244156709;11245.493952771982;11427.200095993201;11503.367314797431;11917.761644766882;11971.880281197426;10851.348919064882;11264.211505194886;11443.370614616277;11448.82826757616;11606.187566870238;9779.364341318076;9814;9913.504324783587;10094.545745441326;10253.641122560675;9075.773105672148;9296.95351523238;9668.85496717564;9749.415035097916;9812.950935245564 08:38:36 INFO - PROCESS | 8677 | __end_tp_report 08:38:36 INFO - PROCESS | 8677 | __start_cc_report 08:38:36 INFO - PROCESS | 8677 | _x_x_mozilla_cycle_collect,304 08:38:36 INFO - PROCESS | 8677 | __end_cc_report 08:38:36 INFO - PROCESS | 8677 | __startTimestamp1450715916090__endTimestamp 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - PROCESS | 8677 | ------- Summary: start ------- 08:38:36 INFO - PROCESS | 8677 | Number of tests: 6 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - PROCESS | 8677 | [#0] dojo.html Cycles:165 Average:5400.34 Median:5637.44 stddev:612.61 (10.9%) stddev-sans-first:588.95 08:38:36 INFO - PROCESS | 8677 | Values: 3168.7 3225.1 3251.6 3274.8 3283.3 5191.9 5398.9 5432.1 5451.2 5468.0 5293.0 5382.3 5388.1 5391.9 5441.0 4642.1 4874.9 5023.4 5036.6 5042.6 4804.1 4958.6 4978.7 5013.5 5039.3 4841.9 4872.6 4887.2 4905.2 4954.1 4839.2 4861.5 4863.8 4871.5 4917.0 4729.6 4813.1 4861.1 4862.4 4897.1 5091.9 5116.3 5151.6 5160.8 5232.2 5778.9 5826.2 5830.0 5832.2 5881.8 5719.7 5822.4 5871.1 5885.2 5922.2 5405.1 5426.3 5430.7 5442.0 5444.4 5931.9 6014.4 6015.1 6015.7 6020.3 5714.2 5758.0 5760.3 5790.9 5791.9 5716.9 5793.4 5825.0 5854.2 5859.7 5821.9 5830.7 5832.4 5853.4 5893.0 5761.9 5789.7 5851.9 5859.5 5873.8 4383.5 4403.6 4424.1 4468.8 4504.0 3995.6 3999.8 4003.4 4013.4 4057.7 5591.7 5610.5 5612.5 5613.5 5616.9 5671.8 5770.2 5850.2 5893.6 5958.1 5536.6 5545.2 5569.7 5572.2 5601.2 4961.5 5070.0 5077.0 5079.0 5121.2 5952.0 5960.2 6033.7 6033.9 6085.3 5775.8 5848.2 5850.1 5856.8 5887.4 5827.4 5894.7 5948.8 6014.3 6017.7 5642.5 5757.0 5759.4 5773.4 5797.9 5811.4 5830.8 5851.7 5866.2 5875.3 5489.7 5596.2 5647.9 5670.7 5684.6 5721.2 5780.2 5791.1 5799.6 5829.2 5586.6 5621.2 5636.5 5637.4 5649.7 5505.3 5541.3 5649.6 5715.8 5745.3 5649.4 5655.6 5660.0 5664.8 5665.0 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - PROCESS | 8677 | [#1] ext.html Cycles:180 Average:45607.02 Median:35800.23 stddev:77094.33 (215.3%) stddev-sans-first:77236.42 08:38:36 INFO - PROCESS | 8677 | Values: 561.9 609.1 610.1 616.4 623.0 35201.5 35862.6 35864.5 35876.3 36068.5 40988.0 41341.8 41453.2 41488.6 41489.6 8751.3 8895.1 8974.1 8981.3 8992.0 8663.4 8802.7 8829.4 8838.6 8846.4 8548.1 8559.4 8564.4 8589.4 8619.5 8699.8 8819.0 8826.6 8828.2 8850.2 8544.3 8606.0 8706.3 8719.5 8728.2 38989.2 39550.6 39608.0 39615.6 39730.4 3015.5 3034.6 3034.9 3081.0 3115.4 29193.9 29567.9 30030.0 30206.0 30621.4 3590.8 3611.0 3611.9 3721.4 3750.3 265448.7 265943.0 266678.0 266821.0 267583.0 48689.5 49869.5 55980.0 56363.7 63795.0 57614.0 57650.0 58465.0 58541.0 58672.0 15275.3 15585.1 15617.2 15742.8 15767.9 12160.5 12219.5 12269.8 12428.9 12453.8 19455.6 19655.0 19765.4 19789.4 19842.0 7676.0 7804.0 7858.5 7942.7 7945.9 929.4 970.8 989.2 1015.7 1021.7 26641.3 27149.9 27612.9 27620.6 27620.7 928.8 941.2 994.4 994.6 1070.5 13255.8 13502.3 13746.1 13747.5 13914.8 314214.0 317490.0 318428.0 319796.0 320276.0 49801.5 50023.2 50288.5 50477.2 50509.7 1299.4 1317.0 1321.8 1354.5 1372.1 25387.9 26594.3 26658.7 26800.7 26887.0 44844.3 44944.6 44996.6 45092.0 45150.3 295576.0 296648.0 298312.0 298999.0 299047.0 30815.2 31132.0 31445.7 31515.4 31552.0 36929.6 38224.2 38344.0 38971.8 41153.2 33644.7 33996.3 34633.8 34978.3 35061.4 34615.3 35737.8 35951.6 36004.0 36456.8 31879.0 32229.8 32467.8 32553.2 32678.3 29547.7 31194.2 31986.5 32012.5 32046.8 22519.1 22668.7 23328.5 23437.3 25488.5 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - PROCESS | 8677 | [#2] jquery.html Cycles:180 Average:28736.61 Median:20109.61 stddev:93591.00 (465.4%) stddev-sans-first:93829.28 08:38:36 INFO - PROCESS | 8677 | Values: 355.8 355.8 355.9 356.9 359.9 16278.6 17096.4 17832.2 17920.3 18433.9 11154.9 11196.6 11397.3 11540.6 11555.6 4779.4 4811.6 4913.7 4916.3 4945.7 4850.5 4914.0 4926.0 4939.7 4960.6 4877.3 4896.0 5175.6 5327.9 5356.3 5247.6 5249.5 5270.4 5319.4 6071.2 5306.6 5356.9 5376.1 5387.3 5391.4 11645.9 12272.0 18373.1 19727.3 19893.3 2072.5 2097.4 2162.1 2185.3 2240.8 9357.2 9640.7 9867.4 10002.4 12527.9 1865.5 1876.1 1877.4 1880.8 1893.5 57203.0 57850.0 57854.4 58920.7 59094.7 9795.0 9803.5 9854.0 9902.4 9906.6 12736.9 12764.4 12812.3 12812.4 12863.0 7438.0 7497.5 7516.8 7534.7 7681.2 7156.9 7209.9 7228.1 7256.9 7269.6 4088.8 4182.6 4242.9 4296.2 4353.8 1796.3 1798.8 1815.7 1829.9 1849.8 913.3 914.7 974.3 999.5 1020.5 16040.9 16189.2 16284.7 16546.3 16583.3 913.0 917.2 924.1 959.9 961.0 9382.4 9778.3 10028.2 10079.2 10123.2 559092.0 564381.0 581579.0 582130.0 584316.0 43201.6 43772.8 44004.6 77492.0 77869.6 1149.5 1157.4 1162.9 1169.5 1181.6 15690.4 16219.3 16347.1 16353.1 16464.5 34715.7 35262.8 35909.0 36059.8 36130.5 43380.9 44205.1 44445.6 44901.3 45895.5 9280.8 9342.0 9632.0 9727.3 9741.2 11467.7 11526.7 15919.7 16754.6 17135.1 13732.9 13803.7 13958.9 14016.4 14668.0 13753.3 13793.5 13977.3 14211.9 14606.2 13896.2 13909.2 14168.0 15062.1 15080.5 9150.5 9578.2 9733.0 9749.3 9824.2 12795.9 13395.5 13929.8 14052.8 14608.3 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - PROCESS | 8677 | [#3] mootools.html Cycles:180 Average:5333.73 Median:6330.60 stddev:2649.40 (41.9%) stddev-sans-first:2641.11 08:38:36 INFO - PROCESS | 8677 | Values: 1494.0 1717.3 1770.3 1770.7 1776.8 6725.7 6903.3 7197.4 7746.5 7761.7 7275.8 7402.1 7478.9 7530.0 7536.6 2247.3 2279.3 2283.1 2288.0 2291.9 2245.5 2300.8 2301.9 2312.8 2329.0 2297.7 2304.8 2340.3 2350.6 2351.9 2272.5 2282.0 2287.8 2293.9 2303.2 2351.4 2351.7 2368.8 2377.1 2377.5 7487.4 7567.2 7585.0 7606.7 7615.0 4565.5 4619.4 4621.2 4636.8 4664.3 2964.1 2973.2 3010.9 3025.8 3055.7 993.6 994.3 1751.9 1754.6 1780.1 10131.1 10210.8 10217.7 10219.2 10241.8 4138.7 4192.8 4268.2 4281.8 4306.4 8449.1 8457.2 8460.8 8462.5 8475.3 4647.8 4700.7 4706.7 4715.9 4726.8 4291.8 4325.9 4326.1 4354.4 4369.5 3544.6 3551.8 3569.9 3606.1 3661.3 1050.4 1052.4 1055.1 1093.9 1116.9 1324.6 1327.3 1337.5 1355.3 1364.1 7153.0 7156.1 7321.9 7334.3 7350.8 1093.3 1094.7 1097.3 1100.8 1117.7 5727.2 5749.0 5795.8 5803.2 5820.0 8879.3 8946.9 9021.4 9089.8 9145.8 9012.8 9030.8 9041.7 9070.8 9079.4 6997.2 7041.8 7083.4 7111.1 7174.2 6917.1 6936.2 6938.0 6956.1 6957.9 7673.1 8006.2 8075.6 8081.5 8216.8 8123.2 8177.8 8272.1 8325.4 8396.8 5509.3 6345.3 6454.7 6497.0 6545.1 7188.0 7218.5 7220.9 7221.2 7252.5 6713.9 6858.8 6937.2 6957.0 6974.9 6765.9 6808.9 6870.3 6952.7 6964.7 6715.4 6721.1 6865.2 6902.6 6927.1 6307.9 6315.9 6347.5 6360.5 6366.3 6514.3 6522.3 6528.7 6540.0 6544.4 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - PROCESS | 8677 | [#4] prototype.html Cycles:180 Average:5627.20 Median:6404.28 stddev:1730.73 (27.0%) stddev-sans-first:1689.49 08:38:36 INFO - PROCESS | 8677 | Values: 340.9 351.6 353.5 356.1 360.0 6334.7 6340.7 6384.7 6386.4 6398.4 6315.1 6320.7 6322.6 6364.8 6365.4 4735.4 4770.2 4776.5 4777.6 4778.0 4778.7 4780.7 4780.7 4781.2 4786.7 4645.7 4725.8 4726.2 4733.1 4736.0 4707.3 4714.4 4722.9 4745.4 4757.5 4064.4 4071.0 4073.0 4073.5 4075.6 6011.3 6038.7 6041.9 6045.4 6063.7 5349.4 5492.0 5495.7 5510.9 5514.5 6722.7 6729.5 6741.2 6750.4 6754.0 4481.6 4491.4 4495.2 4503.6 4509.8 6891.1 6989.1 7049.3 7067.6 7077.2 4716.1 4737.0 4742.2 4743.2 4745.5 4761.1 4770.2 4776.5 4792.3 4810.7 5580.4 5580.6 5584.5 5587.8 5588.6 6643.3 6728.4 6769.2 6769.5 6771.0 1626.0 1650.0 1659.1 1664.0 1679.9 1125.1 1134.8 1136.2 1137.8 1152.7 6298.4 6410.2 6425.0 6464.8 6473.2 6836.3 6865.2 6878.9 6888.4 6900.7 6435.6 6439.4 6450.5 6452.4 6461.3 3789.8 3800.1 3822.9 3832.2 3836.6 7274.0 7298.5 7320.1 7334.6 7348.3 7004.3 7141.1 7189.0 7193.5 7231.6 7287.2 7295.5 7297.0 7309.0 7318.2 6992.1 7001.2 7013.3 7014.7 7037.6 6785.2 6953.5 6963.2 7004.1 7037.5 7288.2 7296.2 7312.5 7328.4 7337.5 4738.3 4739.3 4766.9 4771.6 4776.3 6834.4 6888.8 7058.1 7067.2 7071.6 6802.6 6804.1 6815.8 6822.2 6824.0 6742.2 6818.3 6821.5 6822.2 6830.6 6503.1 6664.7 6679.7 6683.0 6697.9 6773.4 6822.7 6823.0 6825.3 6835.5 6607.4 6632.0 6648.5 6649.0 6672.8 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - PROCESS | 8677 | [#5] yui.html Cycles:180 Average:14005.48 Median:23773.16 stddev:16619.17 (69.9%) stddev-sans-first:16635.73 08:38:36 INFO - PROCESS | 8677 | Values: 695.1 719.6 733.4 762.6 866.1 13302.4 13645.7 13646.7 13662.5 13708.4 12819.3 13001.2 13020.8 13543.8 13570.5 825.5 837.7 838.0 840.1 840.3 823.2 825.9 828.1 829.8 831.6 865.8 865.9 866.1 870.1 872.7 859.2 866.6 867.6 868.1 869.5 630.4 632.7 633.0 635.4 637.0 11861.8 11923.3 11944.0 11981.6 11993.5 10560.3 11092.5 11160.5 11165.4 11225.9 9746.0 9798.0 9868.0 10191.4 10360.7 3474.2 3517.6 3522.1 3533.6 3791.0 43927.8 44599.6 44673.0 45173.0 45280.1 9175.3 9210.0 9267.6 9344.8 9627.1 18379.9 18569.0 18587.3 18627.3 18631.0 7015.1 7048.0 7111.1 7646.7 7758.2 4387.4 4397.9 4421.9 4526.7 4527.3 3091.8 3107.0 3108.9 3109.9 3127.0 567.4 570.0 573.1 575.0 580.7 488.6 555.7 628.4 681.0 693.9 8700.0 8837.9 8863.4 8897.0 8992.7 521.3 536.2 604.5 627.7 653.3 3800.6 3973.5 3987.1 4033.3 4063.8 58120.7 58741.0 58776.4 58847.7 58899.0 55131.7 57031.4 57458.4 57725.7 58213.4 45907.0 46938.3 50910.7 52506.0 52797.9 8582.4 8638.6 8644.6 8834.5 8949.8 36307.3 36594.6 37064.3 37361.3 37519.2 42028.0 46782.3 46799.5 46852.5 47057.8 10218.3 10224.3 10244.8 10701.2 10855.7 12096.3 12273.5 12430.3 12534.0 12602.9 11030.2 11436.6 11647.7 11662.9 11834.1 11245.5 11427.2 11503.4 11917.8 11971.9 10851.3 11264.2 11443.4 11448.8 11606.2 9779.4 9814.0 9913.5 10094.5 10253.6 9075.8 9297.0 9668.9 9749.4 9813.0 08:38:36 INFO - PROCESS | 8677 | -------- Summary: end -------- 08:38:36 INFO - PROCESS | 8677 | 08:38:36 INFO - TEST-INFO | 8677: exit 0 08:38:36 INFO - TEST-OK | dromaeo_css | took 1110296ms 08:38:36 INFO - TEST-START | kraken 08:38:36 INFO - operating with platform_type : linux_ 08:38:36 INFO - Initialising browser for kraken test... 08:38:36 INFO - TEST-INFO | started process 8914 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwfAleX/profile http://localhost:49729/getInfo.html) 08:38:40 INFO - PROCESS | 8914 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 08:38:41 INFO - PROCESS | 8914 | __metrics Screen width/height:1600/1200 08:38:41 INFO - PROCESS | 8914 | colorDepth:24 08:38:41 INFO - PROCESS | 8914 | Browser inner width/height: 1024/697 08:38:41 INFO - PROCESS | 8914 | __metrics 08:38:41 INFO - PROCESS | 8914 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:38:42 INFO - TEST-INFO | 8914: exit 0 08:38:42 INFO - Browser initialized. 08:38:42 INFO - Running cycle 1/1 for kraken test... 08:38:42 INFO - TEST-INFO | started process 9039 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwfAleX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:53 INFO - PROCESS | 9039 | RSS: Main: 150986752 08:38:53 INFO - PROCESS | 9039 | 08:38:56 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49729/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:56 INFO - PROCESS | 9039 | RSS: Main: 152862720 08:38:56 INFO - PROCESS | 9039 | 08:38:59 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49729/tests/kraken/driver.html?testName=audio-dft) 08:39:00 INFO - PROCESS | 9039 | RSS: Main: 151007232 08:39:00 INFO - PROCESS | 9039 | 08:39:03 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49729/tests/kraken/driver.html?testName=audio-fft) 08:39:03 INFO - PROCESS | 9039 | RSS: Main: 146399232 08:39:03 INFO - PROCESS | 9039 | 08:39:05 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49729/tests/kraken/driver.html?testName=audio-oscillator) 08:39:06 INFO - PROCESS | 9039 | RSS: Main: 146489344 08:39:06 INFO - PROCESS | 9039 | 08:39:08 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:39:09 INFO - PROCESS | 9039 | RSS: Main: 146882560 08:39:09 INFO - PROCESS | 9039 | 08:39:11 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49729/tests/kraken/driver.html?testName=imaging-darkroom) 08:39:12 INFO - PROCESS | 9039 | RSS: Main: 148021248 08:39:12 INFO - PROCESS | 9039 | 08:39:15 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49729/tests/kraken/driver.html?testName=imaging-desaturate) 08:39:16 INFO - PROCESS | 9039 | RSS: Main: 148873216 08:39:16 INFO - PROCESS | 9039 | 08:39:19 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49729/tests/kraken/driver.html?testName=json-parse-financial) 08:39:19 INFO - PROCESS | 9039 | RSS: Main: 147546112 08:39:19 INFO - PROCESS | 9039 | 08:39:21 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:22 INFO - PROCESS | 9039 | RSS: Main: 149512192 08:39:22 INFO - PROCESS | 9039 | 08:39:23 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49729/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:24 INFO - PROCESS | 9039 | RSS: Main: 148652032 08:39:24 INFO - PROCESS | 9039 | 08:39:26 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:27 INFO - PROCESS | 9039 | RSS: Main: 148451328 08:39:27 INFO - PROCESS | 9039 | 08:39:29 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:30 INFO - PROCESS | 9039 | RSS: Main: 149372928 08:39:30 INFO - PROCESS | 9039 | 08:39:32 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:33 INFO - PROCESS | 9039 | RSS: Main: 149618688 08:39:33 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | Cycle 1(1): loaded http://localhost:49729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49729/tests/kraken/driver.html?testName=ai-astar) 08:39:35 INFO - PROCESS | 9039 | RSS: Main: 148062208 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | __start_tp_report 08:39:35 INFO - PROCESS | 9039 | _x_x_mozilla_page_load 08:39:35 INFO - PROCESS | 9039 | _x_x_mozilla_page_load_details 08:39:35 INFO - PROCESS | 9039 | |i|pagename|runs| 08:39:35 INFO - PROCESS | 9039 | |0;ai-astar;111;105;111;110;110;125;110;110;111;110 08:39:35 INFO - PROCESS | 9039 | |1;audio-beat-detection;152;124;155;163;124;153;152;125;158;126 08:39:35 INFO - PROCESS | 9039 | |2;audio-dft;161;163;162;162;161;163;161;164;170;165 08:39:35 INFO - PROCESS | 9039 | |3;audio-fft;70;73;72;73;72;72;152;70;71;73 08:39:35 INFO - PROCESS | 9039 | |4;audio-oscillator;93;93;142;93;94;92;141;92;92;134 08:39:35 INFO - PROCESS | 9039 | |5;imaging-gaussian-blur;110;110;111;109;111;111;110;110;110;110 08:39:35 INFO - PROCESS | 9039 | |6;imaging-darkroom;146;148;147;146;146;147;148;148;146;146 08:39:35 INFO - PROCESS | 9039 | |7;imaging-desaturate;96;97;96;96;96;97;95;96;97;96 08:39:35 INFO - PROCESS | 9039 | |8;json-parse-financial;63;62;62;61;62;63;61;61;60;62 08:39:35 INFO - PROCESS | 9039 | |9;json-stringify-tinderbox;68;68;67;68;68;68;69;68;68;68 08:39:35 INFO - PROCESS | 9039 | |10;stanford-crypto-aes;82;87;85;93;85;86;85;86;87;87 08:39:35 INFO - PROCESS | 9039 | |11;stanford-crypto-ccm;120;125;121;131;124;121;136;121;123;132 08:39:35 INFO - PROCESS | 9039 | |12;stanford-crypto-pbkdf2;142;164;154;153;153;141;155;159;153;147 08:39:35 INFO - PROCESS | 9039 | |13;stanford-crypto-sha256-iterative;70;68;74;67;69;66;66;66;66;68 08:39:35 INFO - PROCESS | 9039 | __end_tp_report 08:39:35 INFO - PROCESS | 9039 | __start_cc_report 08:39:35 INFO - PROCESS | 9039 | _x_x_mozilla_cycle_collect,710 08:39:35 INFO - PROCESS | 9039 | __end_cc_report 08:39:35 INFO - PROCESS | 9039 | __startTimestamp1450715975432__endTimestamp 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | ------- Summary: start ------- 08:39:35 INFO - PROCESS | 9039 | Number of tests: 14 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#0] ai-astar Cycles:10 Average:111.30 Median:110.50 stddev:5.12 (4.6%) stddev-sans-first:5.43 08:39:35 INFO - PROCESS | 9039 | Values: 111.0 105.0 111.0 110.0 110.0 125.0 110.0 110.0 111.0 110.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:152.50 stddev:16.21 (10.6%) stddev-sans-first:16.88 08:39:35 INFO - PROCESS | 9039 | Values: 152.0 124.0 155.0 163.0 124.0 153.0 152.0 125.0 158.0 126.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.74 (1.7%) stddev-sans-first:2.79 08:39:35 INFO - PROCESS | 9039 | Values: 161.0 163.0 162.0 162.0 161.0 163.0 161.0 164.0 170.0 165.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#3] audio-fft Cycles:10 Average:79.80 Median:72.00 stddev:25.39 (35.3%) stddev-sans-first:26.69 08:39:35 INFO - PROCESS | 9039 | Values: 70.0 73.0 72.0 73.0 72.0 72.0 152.0 70.0 71.0 73.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:92.50 stddev:22.46 (24.3%) stddev-sans-first:23.28 08:39:35 INFO - PROCESS | 9039 | Values: 93.0 93.0 142.0 93.0 94.0 92.0 141.0 92.0 92.0 134.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 08:39:35 INFO - PROCESS | 9039 | Values: 110.0 110.0 111.0 109.0 111.0 111.0 110.0 110.0 110.0 110.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 08:39:35 INFO - PROCESS | 9039 | Values: 146.0 148.0 147.0 146.0 146.0 147.0 148.0 148.0 146.0 146.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:39:35 INFO - PROCESS | 9039 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 95.0 96.0 97.0 96.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:62.00 stddev:0.95 (1.5%) stddev-sans-first:0.88 08:39:35 INFO - PROCESS | 9039 | Values: 63.0 62.0 62.0 61.0 62.0 63.0 61.0 61.0 60.0 62.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 08:39:35 INFO - PROCESS | 9039 | Values: 68.0 68.0 67.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:2.79 (3.2%) stddev-sans-first:2.49 08:39:35 INFO - PROCESS | 9039 | Values: 82.0 87.0 85.0 93.0 85.0 86.0 85.0 86.0 87.0 87.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:124.50 stddev:5.60 (4.5%) stddev-sans-first:5.59 08:39:35 INFO - PROCESS | 9039 | Values: 120.0 125.0 121.0 131.0 124.0 121.0 136.0 121.0 123.0 132.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:153.50 stddev:7.11 (4.6%) stddev-sans-first:6.53 08:39:35 INFO - PROCESS | 9039 | Values: 142.0 164.0 154.0 153.0 153.0 141.0 155.0 159.0 153.0 147.0 08:39:35 INFO - PROCESS | 9039 | 08:39:35 INFO - PROCESS | 9039 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.54 (3.7%) stddev-sans-first:2.59 08:39:35 INFO - PROCESS | 9039 | Values: 70.0 68.0 74.0 67.0 69.0 66.0 66.0 66.0 66.0 68.0 08:39:35 INFO - PROCESS | 9039 | -------- Summary: end -------- 08:39:35 INFO - PROCESS | 9039 | 08:39:36 INFO - TEST-INFO | 9039: exit 0 08:39:36 INFO - TEST-OK | kraken | took 59500ms 08:39:36 INFO - TEST-START | v8_7 08:39:36 INFO - operating with platform_type : linux_ 08:39:36 INFO - Initialising browser for v8_7 test... 08:39:36 INFO - TEST-INFO | started process 9328 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3vXUsq/profile http://localhost:49729/getInfo.html) 08:39:39 INFO - PROCESS | 9328 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 08:39:40 INFO - PROCESS | 9328 | __metrics Screen width/height:1600/1200 08:39:40 INFO - PROCESS | 9328 | colorDepth:24 08:39:40 INFO - PROCESS | 9328 | Browser inner width/height: 1024/697 08:39:40 INFO - PROCESS | 9328 | __metrics 08:39:40 INFO - PROCESS | 9328 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:39:41 INFO - TEST-INFO | 9328: exit 0 08:39:41 INFO - Browser initialized. 08:39:41 INFO - Running cycle 1/1 for v8_7 test... 08:39:41 INFO - TEST-INFO | started process 9452 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3vXUsq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:53 INFO - PROCESS | 9452 | RSS: Main: 151646208 08:39:53 INFO - PROCESS | 9452 | 08:40:14 INFO - PROCESS | 9452 | Cycle 1(1): loaded http://localhost:49729/tests/v8_7/run.html (next: http://localhost:49729/tests/v8_7/run.html) 08:40:15 INFO - PROCESS | 9452 | RSS: Main: 146276352 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | __start_tp_report 08:40:15 INFO - PROCESS | 9452 | _x_x_mozilla_page_load 08:40:15 INFO - PROCESS | 9452 | _x_x_mozilla_page_load_details 08:40:15 INFO - PROCESS | 9452 | |i|pagename|runs| 08:40:15 INFO - PROCESS | 9452 | |0;Richards;165.94756057085962 08:40:15 INFO - PROCESS | 9452 | |1;DeltaBlue;188.32391713747646 08:40:15 INFO - PROCESS | 9452 | |2;Encrypt;279.2516056967328 08:40:15 INFO - PROCESS | 9452 | |3;Decrypt;5164.948453608247 08:40:15 INFO - PROCESS | 9452 | |4;RayTrace;1051.5247108307046 08:40:15 INFO - PROCESS | 9452 | |5;Earley;708.7172218284904 08:40:15 INFO - PROCESS | 9452 | |6;Boyer;12207.317073170732 08:40:15 INFO - PROCESS | 9452 | |7;RegExp;25250 08:40:15 INFO - PROCESS | 9452 | |8;Splay;679.3478260869565 08:40:15 INFO - PROCESS | 9452 | |9;NavierStokes;4850.241545893719 08:40:15 INFO - PROCESS | 9452 | __end_tp_report 08:40:15 INFO - PROCESS | 9452 | __startTimestamp1450716015113__endTimestamp 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | ------- Summary: start ------- 08:40:15 INFO - PROCESS | 9452 | Number of tests: 10 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#0] Richards Cycles:1 Average:165.95 Median:165.95 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 165.9 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#1] DeltaBlue Cycles:1 Average:188.32 Median:188.32 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 188.3 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 279.3 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 5164.9 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#4] RayTrace Cycles:1 Average:1051.52 Median:1051.52 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 1051.5 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#5] Earley Cycles:1 Average:708.72 Median:708.72 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 708.7 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 12207.3 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 25250.0 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#8] Splay Cycles:1 Average:679.35 Median:679.35 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 679.3 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - PROCESS | 9452 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 08:40:15 INFO - PROCESS | 9452 | Values: 4850.2 08:40:15 INFO - PROCESS | 9452 | -------- Summary: end -------- 08:40:15 INFO - PROCESS | 9452 | 08:40:15 INFO - TEST-INFO | 9452: exit 0 08:40:15 INFO - TEST-OK | v8_7 | took 39619ms 08:40:15 INFO - SUITE-END | took 1209s 08:40:16 INFO - Completed test suite (00:20:09) 08:40:16 INFO - Working with test: dromaeo_css 08:40:16 INFO - Generating results file: dromaeo_css 08:40:16 INFO - Working with test: kraken 08:40:16 INFO - Generating results file: kraken 08:40:16 INFO - javascript benchmark 08:40:16 INFO - Working with test: v8_7 08:40:16 INFO - Generating results file: v8_7 08:40:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:40:16 INFO - process_Request line: dromaeo_css 7001.16 graph.html#tests=[[72,64,43]] 08:40:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:16 INFO - process_Request line: kraken 1518.80 graph.html#tests=[[232,64,43]] 08:40:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:16 INFO - process_Request line: v8_7 21192.51 graph.html#tests=[[230,64,43]] 08:40:16 INFO - RETURN: dromaeo_css: 7001.16 08:40:16 INFO - RETURN: kraken: 1518.80 08:40:16 INFO - RETURN: v8_7: 21192.51 08:40:16 INFO - javascript benchmark 08:40:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3168.6989735975085, 3225.1130938991773, 3251.64231934487, 3274.770766046376, 3283.261266215102, 5191.948080519203, 5398.91901621476, 5432.076546987012, 5451.182322651604, 5467.972660136698, 5293.0, 5382.273393091931, 5388.137897936331, 5391.946080539194, 5440.972795136019, 4642.141203877277, 4874.8537543873745, 5023.3971923369245, 5036.6222533309965, 5042.647014708972, 4804.087223427555, 4958.578520825734, 4978.701277923318, 5013.498650134994, 5039.269305950635, 4841.878953026185, 4872.6345524085655, 4887.169181239198, 4905.2151655734915, 4954.083494553519, 4839.225723884161, 4861.465238823726, 4863.8297659582095, 4871.464138944713, 4917.0, 4729.55069268419, 4813.109574728686, 4861.100696371147, 4862.41651001882, 4897.069556784235, 5091.87270318245, 5116.309298244763, 5151.562117220041, 5160.793568257265, 5232.1628539433505, 5778.930897783924, 5826.242588463515, 5830.0, 5832.2418085649015, 5881.823545293648, 5719.7140142992685, 5822.359540450547, 5871.060630299132, 5885.205497257858, 5922.200502932092, 5405.108157154064, 5426.348838139448, 5430.6741595504, 5442.020436321461, 5444.40111587725, 5931.881362372728, 6014.428629280299, 6015.127806468037, 6015.729292181863, 6020.307664618537, 5714.200011998323, 5758.049921762862, 5760.337561180434, 5790.913136302959, 5791.855203619859, 5716.942830571641, 5793.420657934173, 5825.0, 5854.2096816930025, 5859.677717725566, 5821.912671309934, 5830.679312637845, 5832.416758324219, 5853.443922827325, 5893.027650437715, 5761.942380576224, 5789.681567513827, 5851.941480585139, 5859.53123750099, 5873.794417195378, 4383.49589797171, 4403.625691816167, 4424.137293227854, 4468.821247150077, 4503.954960450419, 3995.600439955981, 3999.8200080996426, 4003.399490076512, 4013.3779264214095, 4057.6753859691153, 5591.692456914828, 5610.523105535994, 5612.466815652507, 5613.522850557667, 5616.9157462638095, 5671.829845104653, 5770.221020162225, 5850.151727999501, 5893.6463812171405, 5958.1062840573395, 5536.612437129363, 5545.1682247663175, 5569.66582005081, 5572.192032155314, 5601.187827764951, 4961.479044700327, 5070.0, 5076.974615126901, 5079.034983353151, 5121.1550094234035, 5952.0, 5960.165576819162, 6033.698315084141, 6033.939660603338, 6085.269767627913, 5775.826725198251, 5848.210491583582, 5850.12248162779, 5856.824295271149, 5887.381824908494, 5827.358990511125, 5894.705264736832, 5948.821535353946, 6014.308354539284, 6017.699115044318, 5642.463965923231, 5757.0, 5759.424057594207, 5773.422657734193, 5797.913031304618, 5811.360750317377, 5830.82507524775, 5851.678157701197, 5866.208061911588, 5875.3243377010485, 5489.725513724377, 5596.18855265976, 5647.85880352978, 5670.716464176692, 5684.573656975661, 5721.170430287668, 5780.21967034445, 5791.102379131242, 5799.594028418139, 5829.213056237354, 5586.553075753849, 5621.184928185308, 5636.464535869086, 5637.43625637433, 5649.717514124195, 5505.339359276913, 5541.251930989426, 5649.576281778801, 5715.799947001835, 5745.2818397700285, 5649.378568357395, 5655.604107712421, 5660.0, 5664.830055098354, 5665.036943719495], "unit": "score", "name": "dojo.html", "value": 5359.9418729412455}, {"lowerIsBetter": false, "replicates": [561.9129034999573, 609.0833295889686, 610.1092405088572, 616.3805375597525, 622.9626222426657, 35201.47197792032, 35862.64137358626, 35864.46203306949, 35876.28247435056, 36068.45897311539, 40988.0, 41341.7932910335, 41453.17093658125, 41488.58511414885, 41489.58510414895, 8751.29989600832, 8895.066018068106, 8974.102589741038, 8981.281497480186, 8992.0, 8663.350248731338, 8802.691905783267, 8829.381943263974, 8838.602262898154, 8846.424982376157, 8548.145185481464, 8559.443636163629, 8564.443311184785, 8589.441686290402, 8619.525926074064, 8699.782505437352, 8818.955905220464, 8826.64693412266, 8828.249598784047, 8850.20348168668, 8544.273736732384, 8605.95697021511, 8706.347023973227, 8719.520426376546, 8728.170823771732, 38989.220215595815, 39550.60449395527, 39608.0, 39615.60384396148, 39730.404043939365, 3015.457217700813, 3034.6055012848187, 3034.9393012139635, 3081.029475715143, 3115.376924615063, 29193.906285759742, 29567.852160739272, 30030.0, 30206.0, 30621.387572248652, 3590.8025058621765, 3610.981945090258, 3611.927761444783, 3721.441783732435, 3750.268697603968, 265448.6727566369, 265943.0, 266678.0, 266821.0, 267583.0, 48689.5131048685, 49869.50130498649, 55980.0, 56363.71818140883, 63795.0, 57614.0, 57650.0, 58465.0, 58541.0, 58672.0, 15275.312610932535, 15585.142817144939, 15617.219139043229, 15742.842571574138, 15767.921160394355, 12160.513579456723, 12219.450124744408, 12269.754604907852, 12428.937855310665, 12453.816887395684, 19455.610887782448, 19655.0, 19765.40703778889, 19789.4063178102, 19842.0, 7676.0, 7804.0, 7858.528488290721, 7942.722004729807, 7945.887575739401, 929.3819609959302, 970.7621632700034, 989.2382865193761, 1015.669907280137, 1021.7139201023725, 26641.33396665099, 27149.864250679017, 27612.861935690195, 27620.58569121465, 27620.723792762215, 928.7863791327898, 941.228192881844, 994.3735446668552, 994.6369575105034, 1070.4968664727567, 13255.801162982563, 13502.32488375597, 13746.106503077268, 13747.450101996008, 13914.791278130837, 314214.0, 317490.0, 318428.0, 319796.0, 320276.0, 49801.50198497969, 50023.24965125453, 50288.49711502838, 50477.24284135741, 50509.747451262505, 1299.3698056442618, 1317.0188209783773, 1321.8281623389091, 1354.5326862232712, 1372.073850151144, 25387.873060634578, 26594.33514162084, 26658.733412666403, 26800.731992679823, 26887.0, 44844.32733508935, 44944.55055449404, 44996.55003449923, 45092.0, 45150.32274515951, 295576.0, 296648.0, 298312.0, 298999.0, 299047.0, 30815.2296192597, 31132.0, 31445.685543144275, 31515.36969260556, 31552.0, 36929.63070369262, 38224.23551529009, 38344.0, 38971.805140975244, 41153.176936460506, 33644.66355336415, 33996.32007359889, 34633.826830865684, 34978.30043399067, 35061.370397220824, 34615.307693845476, 35737.821310893276, 35951.64048359483, 36004.0, 36456.81771591125, 31879.0, 32229.838850806533, 32467.837660811543, 32553.186170345933, 32678.34643307168, 29547.704522954496, 31194.22014449657, 31986.52020219745, 32012.51981220237, 32046.795320467765, 22519.09923603103, 22668.65997010079, 23328.53342933166, 23437.296881093593, 25488.490230195664], "unit": "score", "name": "ext.html", "value": 17982.773310294575}, {"lowerIsBetter": false, "replicates": [355.82208895552225, 355.84342889128766, 355.893232030391, 356.85547353321897, 359.88483685220734, 16278.593035174112, 17096.401625943094, 17832.1975511102, 17920.283188672438, 18433.90783046083, 11154.944225278883, 11196.608118715847, 11397.316161030323, 11540.59607913721, 11555.595554155607, 4779.35478710374, 4811.566958973692, 4913.680610760307, 4916.262560615901, 4945.678530895499, 4850.514948505156, 4914.04176185644, 4926.0394223126505, 4939.654224204307, 4960.553550180483, 4877.26840973855, 4896.045271172123, 5175.5600773934075, 5327.946720532803, 5356.276902618155, 5247.632665713401, 5249.501297376743, 5270.420253772082, 5319.441458646845, 6071.150038994544, 5306.628536002481, 5356.866078348034, 5376.11294136467, 5387.326584176978, 5391.353037635469, 11645.94177029118, 12272.0, 18373.081345932784, 19727.309544165884, 19893.303734369227, 2072.492239401341, 2097.4441772930186, 2162.0703097667997, 2185.3334732906455, 2240.7535171131162, 9357.157855793012, 9640.71077867665, 9867.40795552269, 10002.399856008662, 12527.93736031314, 1865.5149661088215, 1876.1088482970615, 1877.4339412168981, 1880.8495320374336, 1893.5360836594984, 57203.0, 57850.0, 57854.42145578575, 58920.705396473175, 59094.70452647752, 9795.0, 9803.460809655537, 9854.0, 9902.356346837432, 9906.60373585063, 12736.936315318364, 12764.361781910868, 12812.295323757096, 12812.42344094518, 12863.035272354611, 7438.033055702724, 7497.475176737576, 7516.812079698051, 7534.736284230025, 7681.193474685189, 7156.928430715626, 7209.927900720925, 7228.132624085143, 7256.927430725731, 7269.600171990592, 4088.7546747195265, 4182.602652747984, 4242.85150019754, 4296.183725092223, 4353.804078816461, 1796.2814874050484, 1798.8111248319, 1815.7004094324552, 1829.890206587609, 1849.7502837116817, 913.3150137396952, 914.6707185413246, 974.3423189347162, 999.4602914426274, 1020.5152552537634, 16040.919795400949, 16189.19054047293, 16284.674306513803, 16546.255418506196, 16583.253753581117, 912.9680461183826, 917.1791246834047, 924.1082355526814, 959.9232061435068, 960.9519524023771, 9382.390144640576, 9778.339713180541, 10028.19492491344, 10079.244056695778, 10123.1901447884, 559092.0, 564381.0, 581579.0, 582130.0, 584316.0, 43201.56798431976, 43772.78113609475, 44004.55995440068, 77492.0, 77869.61065194638, 1149.4654985431814, 1157.4444266752007, 1162.9011534019535, 1169.473736818435, 1181.5982565927625, 15690.372385104469, 16219.270132843814, 16347.100909450095, 16353.100579468244, 16464.506064818073, 34715.65284347225, 35262.823685881405, 35909.0, 36059.81970090133, 36130.4580431299, 43380.915477113325, 44205.11589768251, 44445.55554444414, 44901.32648010217, 45895.541044589125, 9280.814383712423, 9342.0, 9632.0, 9727.270454716067, 9741.220702343653, 11467.713307167387, 11526.711832204262, 15919.68160636804, 16754.581135471224, 17135.14324283756, 13732.86267137316, 13803.723925521634, 13958.860411395755, 14016.439342426189, 14668.0, 13753.312334383441, 13793.517226897011, 13977.301134943416, 14211.857881421054, 14606.196659183846, 13896.16623002623, 13909.165450073027, 14168.008239423141, 15062.096274223144, 15080.472183473526, 9150.542472876197, 9578.185854202471, 9733.0, 9749.268804839523, 9824.214062875095, 12795.93602031984, 13395.464181433023, 13929.791053134008, 14052.789208161681, 14608.269586520844], "unit": "score", "name": "jquery.html", "value": 8578.84377862831}, {"lowerIsBetter": false, "replicates": [1494.0438119603448, 1717.3216579451114, 1770.3449723602268, 1770.6724256012635, 1776.8400843924044, 6725.730970761164, 6903.275156108612, 7197.352238298552, 7746.53520788753, 7761.6507257173425, 7275.781726548212, 7402.074740657418, 7478.850422991537, 7530.0, 7536.623168841564, 2247.2584047264363, 2279.2592407467555, 2283.098176220392, 2288.0390236100793, 2291.8968646410867, 2245.5059886824874, 2300.769923007694, 2301.9079236830507, 2312.8265380096477, 2328.9534209315802, 2297.6668383084443, 2304.8040916522114, 2340.262817212581, 2350.6003979323555, 2351.8588884666888, 2272.4659704969404, 2281.954360912781, 2287.7712228777154, 2293.86236825791, 2303.2284184798114, 2351.412146963259, 2351.741308456086, 2368.7631236876173, 2377.09670325277, 2377.465070359173, 7487.363574096208, 7567.2054434284155, 7584.962075189644, 7606.695732170707, 7615.0, 4565.4749703784155, 4619.353290539327, 4621.168189725848, 4636.79134438951, 4664.277037059262, 2964.081134848204, 2973.2120987938215, 3010.864511097006, 3025.803322784012, 3055.724984751361, 993.64228877604, 994.3089552760835, 1751.9299228030864, 1754.6052138268915, 1780.1455301455374, 10131.088202061776, 10210.795784084277, 10217.693469195936, 10219.233557483145, 10241.84637230442, 4138.730982486129, 4192.769397683096, 4268.16770729711, 4281.785910704452, 4306.41863348444, 8449.070602233749, 8457.154284571616, 8460.830783384297, 8462.534560599102, 8475.321974242046, 4647.814087436464, 4700.670953033255, 4706.717596944194, 4715.882102947454, 4726.810927562928, 4291.763952982554, 4325.870223893288, 4326.069894972596, 4354.412154359121, 4369.47566292047, 3544.6455354464865, 3551.8046507441823, 3569.94645080324, 3606.062423769839, 3661.2860492204295, 1050.3802756373775, 1052.3633201912885, 1055.055725126008, 1093.9398333091597, 1116.8827273136367, 1324.635725175565, 1327.323065236717, 1337.531863847665, 1355.2884735513935, 1364.0587994283912, 7153.034340364088, 7156.141263048467, 7321.890171647429, 7334.3032411920785, 7350.77947661571, 1093.2729734726477, 1094.715374002765, 1097.314178638351, 1100.763335882789, 1117.6814607836727, 5727.2268243787385, 5748.971255143698, 5795.797147099831, 5803.158542011384, 5820.0, 8879.33404994615, 8946.86579701305, 9021.413608115452, 9089.81820363589, 9145.77135571616, 9012.774680633036, 9030.774230644287, 9041.683541076163, 9070.773230669154, 9079.409838360485, 6997.195322537871, 7041.8239544010785, 7083.433325333961, 7111.111111111111, 7174.210836807947, 6917.13535808024, 6936.20233673134, 6938.0, 6956.130483689539, 6957.860842783217, 7673.079230492377, 8006.159353268056, 8075.5558444286125, 8081.4747041442115, 8216.83566328682, 8123.18768123183, 8177.836443271221, 8272.131426200162, 8325.417220794487, 8396.790080248044, 5509.311336082989, 6345.302016778059, 6454.741810327534, 6497.0, 6545.14913061299, 7188.0, 7218.458615603956, 7220.916862470672, 7221.205667376479, 7252.492325537372, 6713.932860671331, 6858.794236172923, 6937.167539895245, 6957.0, 6974.895376569457, 6765.898511522233, 6808.897866531907, 6870.27862074475, 6952.7485052691, 6964.686589103604, 6715.395614394728, 6721.059051732859, 6865.210500792473, 6902.620355880274, 6927.099477067949, 6307.936920630735, 6315.905261421174, 6347.5239357047485, 6360.4911607072245, 6366.267879193952, 6514.250861151028, 6522.315156908646, 6528.67356632176, 6540.018997150465, 6544.411003009752], "unit": "score", "name": "mootools.html", "value": 4474.379267397523}, {"lowerIsBetter": false, "replicates": [340.933517963997, 351.6439852985001, 353.5403974832717, 356.07065558891287, 360.04946940078185, 6334.651594162319, 6340.651264180468, 6384.712687929037, 6386.361363863612, 6398.360163983611, 6315.084312774645, 6320.715567799449, 6322.557420980534, 6364.777232796853, 6365.427111559959, 4735.4080739907595, 4770.21291486906, 4776.522347765213, 4777.570018698317, 4778.044391121773, 4778.737169455679, 4780.737059461728, 4780.737059461728, 4781.235002399617, 4786.712797232177, 4645.69802962808, 4725.763711814413, 4726.196546587088, 4733.124371991175, 4735.9526404736025, 4707.31743897133, 4714.387129673138, 4722.881927951795, 4745.430548334222, 4757.548032936866, 4064.410660454247, 4071.0, 4072.9796351018354, 4073.4500842386196, 4075.633193012643, 6011.338752737195, 6038.728257228435, 6041.909371359433, 6045.425684559959, 6063.696815159225, 5349.384820745625, 5492.0, 5495.670259784426, 5510.862228444281, 5514.531264842453, 6722.66386680664, 6729.49528785343, 6741.191057073133, 6750.426213771835, 6754.0, 4481.619062379669, 4491.393661855673, 4495.168393847116, 4503.639708823286, 4509.842155524541, 6891.138607674041, 6989.126359205099, 7049.259827718067, 7067.646617669096, 7077.186123595749, 4716.127516409475, 4737.0, 4742.170120228946, 4743.169945259566, 4745.454272758677, 4761.095391875532, 4770.236762118045, 4776.47458779534, 4792.2811578262845, 4810.7113573185725, 5580.358258800209, 5580.581456390787, 5584.497395234367, 5587.776488940397, 5588.608797384144, 6643.30245324234, 6728.394444500019, 6769.221539523018, 6769.458443324522, 6771.0182023607285, 1625.959351016234, 1649.991750041242, 1659.120666046973, 1663.9584010399838, 1679.8908070975347, 1125.0661950580998, 1134.7617000430002, 1136.2160109524402, 1137.78382107401, 1152.6657269391783, 6298.433141017331, 6410.1987251593555, 6424.967875160594, 6464.838379040468, 6473.190851143607, 6836.316368363124, 6865.176178858569, 6878.931210687929, 6888.448924086061, 6900.654967251618, 6435.581687190318, 6439.420452159328, 6450.516211284079, 6452.354764523604, 6461.25695545009, 3789.77261364319, 3800.1259710266795, 3822.8853134406013, 3832.176082142297, 3836.5971572984995, 7273.963630181921, 7298.452616053817, 7320.084989376328, 7334.559926404433, 7348.338649521569, 7004.334588214111, 7141.107361579802, 7189.0294810201, 7193.460490463236, 7231.602261875647, 7287.161976372785, 7295.489315747846, 7297.0, 7309.049823522908, 7318.158411782607, 6992.056072430157, 7001.229864714979, 7013.333733295329, 7014.719411223698, 7037.648117593997, 6785.219699734396, 6953.513254072166, 6963.2340442552295, 7004.0544526488275, 7037.507374483737, 7288.234735352712, 7296.160941491797, 7312.451566132668, 7328.3770879473705, 7337.523061001018, 4738.312944622941, 4739.312799644102, 4766.856994290177, 4771.618270538418, 4776.259679749644, 6834.384905358542, 6888.793336199922, 7058.082449281561, 7067.187273463617, 7071.646417679199, 6802.557833740791, 6804.11546498952, 6815.829604259933, 6822.181338239443, 6824.044633751378, 6742.157230346207, 6818.318168183142, 6821.454283657395, 6822.249552549315, 6830.624315662686, 6503.089567460464, 6664.7000884959325, 6679.732810687518, 6683.0, 6697.866042679217, 6773.424258938046, 6822.692978816064, 6823.044773731583, 6825.317468253135, 6835.521513494206, 6607.405333520006, 6631.966840165768, 6648.468122550281, 6649.0026496025985, 6672.763709600937], "unit": "score", "name": "prototype.html", "value": 5062.704274487074}, {"lowerIsBetter": false, "replicates": [695.0512550368745, 719.5610677486735, 733.4132693844923, 762.6186906546727, 866.1165611076703, 13302.401391937361, 13645.658858528543, 13646.727065458685, 13662.453501859925, 13708.383122759475, 12819.294938778363, 13001.154924929897, 13020.804687929689, 13543.796843047363, 13570.457181712743, 825.5088222507599, 837.656560810068, 837.9622916968721, 840.0507426607925, 840.277361469136, 823.1685997142869, 825.8513467575834, 828.1015098617977, 829.8298848735994, 831.5634291996689, 865.7878819689184, 865.9004214515317, 866.1338661338661, 870.1211776106115, 872.742540950418, 859.166608389864, 866.6403442571357, 867.5748883047262, 868.097178933908, 869.4565896314804, 630.4326106504183, 632.705791806812, 632.987340253197, 635.4471609699544, 636.9713362898681, 11861.822072668916, 11923.344216068113, 11944.0, 11981.580644677482, 11993.520259189621, 10560.313579617377, 11092.500837462334, 11160.497777600027, 11165.38590377529, 11225.943870280678, 9745.951270243675, 9797.951010244904, 9868.013198680146, 10191.439470829102, 10360.740981475448, 3474.2009337852182, 3517.6482351764876, 3522.119470132467, 3533.593636731783, 3790.9810450947843, 43927.78036109831, 44599.55400445987, 44673.0, 45173.0, 45280.094398111854, 9175.265978721687, 9209.967471306305, 9267.629294828132, 9344.813103737888, 9627.085426884434, 18379.90810045968, 18569.0, 18587.34944276944, 18627.254909803458, 18631.0, 7015.052967849377, 7047.964760176166, 7111.111111111111, 7646.655900484491, 7758.185390534026, 4387.3857659927, 4397.934030989538, 4421.889452763642, 4526.660500462479, 4527.253003254426, 3091.7990330628436, 3106.968930310713, 3108.9222769430944, 3109.9067027989195, 3126.968730312668, 567.3730527766841, 570.0309473894396, 573.063041926445, 574.9913751293734, 580.7328628830785, 488.5554145727442, 555.7110302642684, 628.4030171337248, 680.9863802723918, 693.9063226464464, 8700.0, 8837.91162088371, 8863.423877448075, 8896.955515222382, 8992.685256016008, 521.2702216896375, 536.1849988018269, 604.5254475236918, 627.7489004398277, 653.2552889705739, 3800.5819359870393, 3973.4834471518516, 3987.1228329767405, 4033.294173519681, 4063.79681015948, 58120.709396452745, 58741.0, 58776.41223587709, 58847.70576147092, 58899.0, 55131.72434137804, 57031.42968570344, 57458.42541574531, 57725.711371443715, 58213.41786582165, 45907.0, 46938.29592556114, 50910.74544627253, 52506.0, 52797.944041118964, 8582.442141261048, 8638.56807159652, 8644.567771611268, 8834.469931804113, 8949.821003579762, 36307.27385452329, 36594.63405365912, 37064.25871482609, 37361.25277494489, 37519.24961500809, 42028.0, 46782.298265525365, 46799.53200467952, 46852.531474684816, 47057.76471117623, 10218.284720069523, 10224.284300098921, 10244.795104098026, 10701.197410194422, 10855.728606784893, 12096.274223546263, 12273.518425239234, 12430.254184748583, 12534.0, 12602.936985315382, 11030.227884048361, 11436.599719009795, 11647.708807279885, 11662.94168529152, 11834.11244156709, 11245.493952771982, 11427.200095993201, 11503.367314797431, 11917.761644766882, 11971.880281197426, 10851.348919064882, 11264.211505194886, 11443.370614616277, 11448.82826757616, 11606.187566870238, 9779.364341318076, 9814.0, 9913.504324783587, 10094.545745441326, 10253.641122560675, 9075.773105672148, 9296.95351523238, 9668.85496717564, 9749.415035097916, 9812.950935245564], "unit": "score", "name": "yui.html", "value": 6286.721158566117}], "name": "dromaeo_css", "value": 7001.161533995729}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 110.0, 110.0, 125.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 155.0, 163.0, 124.0, 153.0, 152.0, 125.0, 158.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 162.0, 161.0, 163.0, 161.0, 164.0, 170.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 72.0, 73.0, 72.0, 72.0, 152.0, 70.0, 71.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 142.0, 93.0, 94.0, 92.0, 141.0, 92.0, 92.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 109.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 147.0, 148.0, 148.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 62.0, 61.0, 62.0, 63.0, 61.0, 61.0, 60.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 61.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 87.0, 85.0, 93.0, 85.0, 86.0, 85.0, 86.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 121.0, 131.0, 124.0, 121.0, 136.0, 121.0, 123.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [142.0, 164.0, 154.0, 153.0, 153.0, 141.0, 155.0, 159.0, 153.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 74.0, 67.0, 69.0, 66.0, 66.0, 66.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1518.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.94756057085962], "unit": "score", "name": "Richards", "value": 212.72985200000008}, {"lowerIsBetter": false, "replicates": [188.32391713747646], "unit": "score", "name": "DeltaBlue", "value": 351.08658000000014}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1051.5247108307046], "unit": "score", "name": "RayTrace", "value": 703.7295389999999}, {"lowerIsBetter": false, "replicates": [708.7172218284904], "unit": "score", "name": "Earley", "value": 940.379293}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25250.0], "unit": "score", "name": "RegExp", "value": 36.07861386138617}, {"lowerIsBetter": false, "replicates": [679.3478260869565], "unit": "score", "name": "Splay", "value": 119.95475200000003}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21192.50991657849}]} 08:40:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21192.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1518.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7001.16"}}} 08:40:16 INFO - Return code: 0 08:40:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:40:16 INFO - # TBPL SUCCESS # 08:40:16 INFO - Running post-action listener: _resource_record_post_action 08:40:16 INFO - Running post-run listener: _resource_record_post_run 08:40:17 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 566312960; Read time: 16; Write time: 530916 08:40:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243888128; Read time: 0; Write time: 333464 08:40:17 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322424832; Read time: 16; Write time: 197452 08:40:17 INFO - Running post-run listener: _upload_blobber_files 08:40:17 INFO - Blob upload gear active. 08:40:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:40:17 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 08:40:17 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'] 08:40:17 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 08:40:18 INFO - (blobuploader) - INFO - Open directory for files ... 08:40:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:40:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:18 INFO - (blobuploader) - INFO - Done attempting. 08:40:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:40:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:40:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:19 INFO - (blobuploader) - INFO - Done attempting. 08:40:19 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:19 INFO - Return code: 0 08:40:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:40:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ffb3243af37a15830f8a905e74584d5408133a77aec7a85f0cc91c11943ca964aba2d0d2a2086d0e1f372ed7100489e20334b257748db43c442effb5e2793e19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b25e3140b0991a6326175274b1d7b655a82f8b1565c09fe0f6e765c32952794f0fdcd958c47c3b8ced173364547bd6e1e3264887465fc2ca7c95b8d1b5409c61"} 08:40:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:40:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:40:19 INFO - Contents: 08:40:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ffb3243af37a15830f8a905e74584d5408133a77aec7a85f0cc91c11943ca964aba2d0d2a2086d0e1f372ed7100489e20334b257748db43c442effb5e2793e19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b25e3140b0991a6326175274b1d7b655a82f8b1565c09fe0f6e765c32952794f0fdcd958c47c3b8ced173364547bd6e1e3264887465fc2ca7c95b8d1b5409c61"} 08:40:19 INFO - Copying logs to upload dir... 08:40:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.748063 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-12-21 08:40:19.586979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 08:40:19.590582) ========= 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=d6a7e047ef025f707024e163000001c3-1450714755.907910-840275645 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/ffb3243af37a15830f8a905e74584d5408133a77aec7a85f0cc91c11943ca964aba2d0d2a2086d0e1f372ed7100489e20334b257748db43c442effb5e2793e19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b25e3140b0991a6326175274b1d7b655a82f8b1565c09fe0f6e765c32952794f0fdcd958c47c3b8ced173364547bd6e1e3264887465fc2ca7c95b8d1b5409c61"} build_url:https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/cq2bznJjRHewPjvSHGQ2Eg/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/ffb3243af37a15830f8a905e74584d5408133a77aec7a85f0cc91c11943ca964aba2d0d2a2086d0e1f372ed7100489e20334b257748db43c442effb5e2793e19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b25e3140b0991a6326175274b1d7b655a82f8b1565c09fe0f6e765c32952794f0fdcd958c47c3b8ced173364547bd6e1e3264887465fc2ca7c95b8d1b5409c61"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 08:40:19.615862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:40:19.616231) ========= 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=d6a7e047ef025f707024e163000001c3-1450714755.907910-840275645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 08:40:19.702064) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 08:40:19.702413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 08:40:19.702777) ========= ========= Total master_lag: 0.24 =========