builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1452701244.63 results: success (0) buildid: 20160113053005 builduid: 034564d3cba64d379b3aaa959b18a785 revision: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.631206) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.631590) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.631869) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006348 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.658583) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.658858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.704475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.704722) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.754496) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.754764) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.755114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.755384) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 08:07:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.8M=0s 2016-01-13 08:07:25 (97.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170175 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.937544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.937816) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021057 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:24.987436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 08:07:24.987741) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 --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 cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 08:07:25,355 truncating revision to first 12 chars 2016-01-13 08:07:25,355 Setting DEBUG logging. 2016-01-13 08:07:25,355 attempt 1/10 2016-01-13 08:07:25,355 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cae1c805bf91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 08:07:26,349 unpacking tar archive at: fx-team-cae1c805bf91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.290275 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 08:07:26.291263) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:26.291553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:26.313706) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:26.313961) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 08:07:26.314341) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-13 08:07:26.314617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:07:26 INFO - MultiFileLogger online at 20160113 08:07:26 in /builds/slave/test-pgo 08:07:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:07:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:07:26 INFO - {'append_to_log': False, 08:07:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:07:26 INFO - 'blob_upload_branch': 'Fx-Team', 08:07:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:07:26 INFO - 'branch': 'Fx-Team', 08:07:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:07:26 INFO - 'config_files': ('talos/linux_config.py',), 08:07:26 INFO - 'default_actions': ('clobber', 08:07:26 INFO - 'read-buildbot-config', 08:07:26 INFO - 'download-and-extract', 08:07:26 INFO - 'populate-webroot', 08:07:26 INFO - 'create-virtualenv', 08:07:26 INFO - 'install', 08:07:26 INFO - 'run-tests'), 08:07:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:07:26 INFO - 'download_minidump_stackwalk': True, 08:07:26 INFO - 'download_symbols': 'ondemand', 08:07:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:07:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:07:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:07:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:07:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:07:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:07:26 INFO - 'installer_path': 'installer.exe', 08:07:26 INFO - 'log_level': 'info', 08:07:26 INFO - 'log_name': 'talos', 08:07:26 INFO - 'log_to_console': True, 08:07:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:07:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:07:26 INFO - 'opt_config_files': (), 08:07:26 INFO - 'pip_index': False, 08:07:26 INFO - 'sps_profile': False, 08:07:26 INFO - 'sps_profile_interval': 0, 08:07:26 INFO - 'suite': 'dromaeojs', 08:07:26 INFO - 'system_bits': '32', 08:07:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:07:26 INFO - 'title': 'talos-linux64-ix-031', 08:07:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:07:26 INFO - 'use_talos_json': True, 08:07:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:07:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:07:26 INFO - 'work_dir': 'build'} 08:07:26 INFO - ##### 08:07:26 INFO - ##### Running clobber step. 08:07:26 INFO - ##### 08:07:26 INFO - Running pre-action listener: _resource_record_pre_action 08:07:26 INFO - Running main action method: clobber 08:07:26 INFO - rmtree: /builds/slave/test-pgo/build 08:07:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:07:27 INFO - Running post-action listener: _resource_record_post_action 08:07:27 INFO - ##### 08:07:27 INFO - ##### Running read-buildbot-config step. 08:07:27 INFO - ##### 08:07:27 INFO - Running pre-action listener: _resource_record_pre_action 08:07:27 INFO - Running main action method: read_buildbot_config 08:07:27 INFO - Using buildbot properties: 08:07:27 INFO - { 08:07:27 INFO - "project": "", 08:07:27 INFO - "product": "firefox", 08:07:27 INFO - "script_repo_revision": "production", 08:07:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:07:27 INFO - "repository": "", 08:07:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:07:27 INFO - "buildid": "20160113053005", 08:07:27 INFO - "pgo_build": "True", 08:07:27 INFO - "basedir": "/builds/slave/test-pgo", 08:07:27 INFO - "buildnumber": 895, 08:07:27 INFO - "slavename": "talos-linux64-ix-031", 08:07:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:07:27 INFO - "platform": "ubuntu64_hw", 08:07:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:07:27 INFO - "branch": "fx-team", 08:07:27 INFO - "repo_path": "integration/fx-team", 08:07:27 INFO - "revision": "cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56", 08:07:27 INFO - "stage_platform": "linux64-pgo", 08:07:27 INFO - "builduid": "034564d3cba64d379b3aaa959b18a785", 08:07:27 INFO - "slavebuilddir": "test" 08:07:27 INFO - } 08:07:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:07:27 INFO - Running post-action listener: _resource_record_post_action 08:07:27 INFO - ##### 08:07:27 INFO - ##### Running download-and-extract step. 08:07:27 INFO - ##### 08:07:27 INFO - Running pre-action listener: _resource_record_pre_action 08:07:27 INFO - Running main action method: download_and_extract 08:07:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:27 INFO - https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/test_packages.json 08:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/test_packages.json 08:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:07:27 INFO - Downloaded 1448 bytes. 08:07:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:07:27 INFO - Using the following test package requirements: 08:07:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:27 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:27 INFO - u'jsshell-linux-x86_64.zip'], 08:07:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:27 INFO - https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/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:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/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:07:30 INFO - Downloaded 24028739 bytes. 08:07:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 08:07:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:07:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:07:31 INFO - Return code: 0 08:07:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:07: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:07:31 INFO - https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/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:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/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:07:39 INFO - Downloaded 24028739 bytes. 08:07:39 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:07:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:07:39 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:07:40 INFO - Return code: 0 08:07: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:07:40 INFO - https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/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:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/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:07:43 INFO - Downloaded 11132279 bytes. 08:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 08:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:07:43 INFO - Return code: 0 08:07: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:07:43 INFO - https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/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:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/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:07:46 INFO - Downloaded 55892911 bytes. 08:07:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:07:46 INFO - mkdir: /builds/slave/test-pgo/properties 08:07:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:07:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:07:46 INFO - Contents: 08:07:46 INFO - build_url:https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:07:46 INFO - Running post-action listener: _resource_record_post_action 08:07:46 INFO - Running post-action listener: set_extra_try_arguments 08:07:46 INFO - ##### 08:07:46 INFO - ##### Running populate-webroot step. 08:07:46 INFO - ##### 08:07:46 INFO - Running pre-action listener: _resource_record_pre_action 08:07:46 INFO - Running main action method: populate_webroot 08:07:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:46 INFO - '--tppagecycles', 08:07:46 INFO - '7'], 08:07:46 INFO - 'tests': ['tsvgm']}}, 08:07:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:07:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:07:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:07:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'tests': ['damp', 'tps']}, 08:07:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['damp', 'tps']}, 08:07:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:07:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:46 INFO - 'other': {'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other_l64': {'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'other_nol64': {'tests': ['a11yr', 08:07:46 INFO - 'ts_paint', 08:07:46 INFO - 'tpaint', 08:07:46 INFO - 'sessionrestore', 08:07:46 INFO - 'sessionrestore_no_auto_restore']}, 08:07:46 INFO - 'svgr': {'tests': ['tsvgx', 08:07:46 INFO - 'tsvgr_opacity', 08:07:46 INFO - 'tart', 08:07:46 INFO - 'tscrollx', 08:07:46 INFO - 'cart']}, 08:07:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['tsvgx', 08:07:46 INFO - 'tsvgr_opacity', 08:07:46 INFO - 'tart', 08:07:46 INFO - 'tscrollx', 08:07:46 INFO - 'cart']}, 08:07:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'tests': ['tp5o']}, 08:07:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--e10s'], 08:07:46 INFO - 'tests': ['tp5o']}, 08:07:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--xperf_path', 08:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:46 INFO - 'tests': ['tp5n']}, 08:07:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:46 INFO - 'talos_options': ['--e10s', 08:07:46 INFO - '--xperf_path', 08:07:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:46 INFO - 'tests': ['tp5n']}}, 08:07:46 INFO - 'talos.zip': {'path': '', 08:07:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:46 INFO - Running post-action listener: _resource_record_post_action 08:07:46 INFO - ##### 08:07:46 INFO - ##### Running create-virtualenv step. 08:07:46 INFO - ##### 08:07:46 INFO - Running pre-action listener: _resource_record_pre_action 08:07:46 INFO - Running main action method: create_virtualenv 08:07:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:07:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 08:07:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:07:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:46 INFO - Using real prefix '/usr' 08:07:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:07:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:49 INFO - Installing pip.................done. 08:07:49 INFO - Return code: 0 08:07:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:07:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:07:49 INFO - Using env: {'DISPLAY': ':0', 08:07:49 INFO - 'HOME': '/home/cltbld', 08:07:49 INFO - 'LANG': 'en_US.UTF-8', 08:07:49 INFO - 'LANGUAGE': 'en_US:en', 08:07:49 INFO - 'LOGNAME': 'cltbld', 08:07:49 INFO - 'MAIL': '/var/mail/cltbld', 08:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:49 INFO - 'MOZ_NO_REMOTE': '1', 08:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:49 INFO - 'NO_EM_RESTART': '1', 08:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:49 INFO - 'SHELL': '/bin/bash', 08:07:49 INFO - 'SHLVL': '1', 08:07:49 INFO - 'TERM': 'linux', 08:07:49 INFO - 'TMOUT': '86400', 08:07:49 INFO - 'USER': 'cltbld', 08:07:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:49 INFO - '_': '/tools/buildbot/bin/python'} 08:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:07:49 INFO - Cleaning up... 08:07:49 INFO - Return code: 0 08:07:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:07:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:07:49 INFO - Using env: {'DISPLAY': ':0', 08:07:49 INFO - 'HOME': '/home/cltbld', 08:07:49 INFO - 'LANG': 'en_US.UTF-8', 08:07:49 INFO - 'LANGUAGE': 'en_US:en', 08:07:49 INFO - 'LOGNAME': 'cltbld', 08:07:49 INFO - 'MAIL': '/var/mail/cltbld', 08:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:49 INFO - 'MOZ_NO_REMOTE': '1', 08:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:49 INFO - 'NO_EM_RESTART': '1', 08:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:49 INFO - 'SHELL': '/bin/bash', 08:07:49 INFO - 'SHLVL': '1', 08:07:49 INFO - 'TERM': 'linux', 08:07:49 INFO - 'TMOUT': '86400', 08:07:49 INFO - 'USER': 'cltbld', 08:07:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:49 INFO - '_': '/tools/buildbot/bin/python'} 08:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:49 INFO - Downloading/unpacking psutil>=0.7.1 08:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:07:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:07:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:51 INFO - Installing collected packages: psutil 08:07:51 INFO - Running setup.py install for psutil 08:07:51 INFO - building 'psutil._psutil_linux' extension 08:07:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:07:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:07:51 INFO - building 'psutil._psutil_posix' extension 08:07:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:07:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:07:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:51 INFO - Successfully installed psutil 08:07:51 INFO - Cleaning up... 08:07:52 INFO - Return code: 0 08:07:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:07:52 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:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:52 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:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:52 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 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:07:52 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:07:52 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:07:52 INFO - Using env: {'DISPLAY': ':0', 08:07:52 INFO - 'HOME': '/home/cltbld', 08:07:52 INFO - 'LANG': 'en_US.UTF-8', 08:07:52 INFO - 'LANGUAGE': 'en_US:en', 08:07:52 INFO - 'LOGNAME': 'cltbld', 08:07:52 INFO - 'MAIL': '/var/mail/cltbld', 08:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:52 INFO - 'MOZ_NO_REMOTE': '1', 08:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:52 INFO - 'NO_EM_RESTART': '1', 08:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:52 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:52 INFO - 'SHELL': '/bin/bash', 08:07:52 INFO - 'SHLVL': '1', 08:07:52 INFO - 'TERM': 'linux', 08:07:52 INFO - 'TMOUT': '86400', 08:07:52 INFO - 'USER': 'cltbld', 08:07:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:52 INFO - '_': '/tools/buildbot/bin/python'} 08:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:07:52 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:07:52 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:07:52 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:07:52 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:07:52 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:07:52 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:07:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:07:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:07:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:54 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:07:54 INFO - Installing collected packages: mozsystemmonitor 08:07:54 INFO - Running setup.py install for mozsystemmonitor 08:07:54 INFO - Successfully installed mozsystemmonitor 08:07:54 INFO - Cleaning up... 08:07:54 INFO - Return code: 0 08:07:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:07:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:07:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:07:54 INFO - Using env: {'DISPLAY': ':0', 08:07:54 INFO - 'HOME': '/home/cltbld', 08:07:54 INFO - 'LANG': 'en_US.UTF-8', 08:07:54 INFO - 'LANGUAGE': 'en_US:en', 08:07:54 INFO - 'LOGNAME': 'cltbld', 08:07:54 INFO - 'MAIL': '/var/mail/cltbld', 08:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:54 INFO - 'MOZ_NO_REMOTE': '1', 08:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:54 INFO - 'NO_EM_RESTART': '1', 08:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:54 INFO - 'SHELL': '/bin/bash', 08:07:54 INFO - 'SHLVL': '1', 08:07:54 INFO - 'TERM': 'linux', 08:07:54 INFO - 'TMOUT': '86400', 08:07:54 INFO - 'USER': 'cltbld', 08:07:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:54 INFO - '_': '/tools/buildbot/bin/python'} 08:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:07:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:07:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:07:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:07:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:07:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:56 INFO - Downloading docopt-0.6.1.tar.gz 08:07:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:07:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:07:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:07:56 INFO - Running setup.py install for blobuploader 08:07:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:07:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:07:56 INFO - Running setup.py install for requests 08:07:57 INFO - Running setup.py install for docopt 08:07:57 INFO - Successfully installed blobuploader requests docopt 08:07:57 INFO - Cleaning up... 08:07:57 INFO - Return code: 0 08:07:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:07:57 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:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:57 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:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:57 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 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:07:57 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:07:57 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:07:57 INFO - Using env: {'DISPLAY': ':0', 08:07:57 INFO - 'HOME': '/home/cltbld', 08:07:57 INFO - 'LANG': 'en_US.UTF-8', 08:07:57 INFO - 'LANGUAGE': 'en_US:en', 08:07:57 INFO - 'LOGNAME': 'cltbld', 08:07:57 INFO - 'MAIL': '/var/mail/cltbld', 08:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:57 INFO - 'MOZ_NO_REMOTE': '1', 08:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:57 INFO - 'NO_EM_RESTART': '1', 08:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:57 INFO - 'SHELL': '/bin/bash', 08:07:57 INFO - 'SHLVL': '1', 08:07:57 INFO - 'TERM': 'linux', 08:07:57 INFO - 'TMOUT': '86400', 08:07:57 INFO - 'USER': 'cltbld', 08:07:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:57 INFO - '_': '/tools/buildbot/bin/python'} 08:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:07:57 INFO - Running setup.py (path:/tmp/pip-v01_VT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:07:57 INFO - Running setup.py (path:/tmp/pip-m7ZqRd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:07:57 INFO - Running setup.py (path:/tmp/pip-NobQL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:07:57 INFO - Running setup.py (path:/tmp/pip-fit5kx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:07:57 INFO - Running setup.py (path:/tmp/pip-jTu_Gb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:07:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:07:57 INFO - Running setup.py (path:/tmp/pip-SkcHQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:07:58 INFO - Running setup.py (path:/tmp/pip-u_55Kc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:07:58 INFO - Running setup.py (path:/tmp/pip-YQ5fDy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:07:58 INFO - Running setup.py (path:/tmp/pip-LomQU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:07:58 INFO - Running setup.py (path:/tmp/pip-vDv8li-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:07:58 INFO - Running setup.py (path:/tmp/pip-Wvbfm2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:07:58 INFO - Running setup.py (path:/tmp/pip-cfAqme-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:07:58 INFO - Running setup.py (path:/tmp/pip-GTIe_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:07:58 INFO - Running setup.py (path:/tmp/pip-Qgu8BF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:07:58 INFO - Running setup.py (path:/tmp/pip-Q2vVVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:07:58 INFO - Running setup.py (path:/tmp/pip-gmjn98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:07:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:07:58 INFO - Running setup.py (path:/tmp/pip-tT_2pc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:07:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:58 INFO - Running setup.py install for manifestparser 08:07:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:07:58 INFO - Running setup.py install for mozcrash 08:07:59 INFO - Running setup.py install for mozdebug 08:07:59 INFO - Running setup.py install for mozdevice 08:07:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Running setup.py install for mozfile 08:07:59 INFO - Running setup.py install for mozhttpd 08:07:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Running setup.py install for mozinfo 08:07:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Running setup.py install for mozInstall 08:07:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Running setup.py install for mozleak 08:07:59 INFO - Running setup.py install for mozlog 08:07:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Running setup.py install for moznetwork 08:07:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:07:59 INFO - Running setup.py install for mozprocess 08:08:00 INFO - Running setup.py install for mozprofile 08:08:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Running setup.py install for mozrunner 08:08:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Running setup.py install for mozscreenshot 08:08:00 INFO - Running setup.py install for moztest 08:08:00 INFO - Running setup.py install for mozversion 08:08:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:08:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:00 INFO - Cleaning up... 08:08:00 INFO - Return code: 0 08:08:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:08:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:08:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:08:00 INFO - Using env: {'DISPLAY': ':0', 08:08:00 INFO - 'HOME': '/home/cltbld', 08:08:00 INFO - 'LANG': 'en_US.UTF-8', 08:08:00 INFO - 'LANGUAGE': 'en_US:en', 08:08:00 INFO - 'LOGNAME': 'cltbld', 08:08:00 INFO - 'MAIL': '/var/mail/cltbld', 08:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:00 INFO - 'MOZ_NO_REMOTE': '1', 08:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:00 INFO - 'NO_EM_RESTART': '1', 08:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:00 INFO - 'SHELL': '/bin/bash', 08:08:00 INFO - 'SHLVL': '1', 08:08:00 INFO - 'TERM': 'linux', 08:08:00 INFO - 'TMOUT': '86400', 08:08:00 INFO - 'USER': 'cltbld', 08:08:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:00 INFO - '_': '/tools/buildbot/bin/python'} 08:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:00 INFO - Running setup.py (path:/tmp/pip-zaKfeO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 08:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:00 INFO - Running setup.py (path:/tmp/pip-Nm4wKf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 08:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:00 INFO - Running setup.py (path:/tmp/pip-Dh6szX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:08:01 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:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:01 INFO - Running setup.py (path:/tmp/pip-OCSpTe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:01 INFO - Running setup.py (path:/tmp/pip-JVBROf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:08:01 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:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:01 INFO - Running setup.py (path:/tmp/pip-uyrkPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:08:01 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:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:01 INFO - Running setup.py (path:/tmp/pip-DiXYYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:08:01 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:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:01 INFO - Running setup.py (path:/tmp/pip-XB8iFT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:08:01 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:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:01 INFO - Running setup.py (path:/tmp/pip-jBmkhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:08:01 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:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:01 INFO - Running setup.py (path:/tmp/pip-oLkRpr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:01 INFO - Running setup.py (path:/tmp/pip-TikHAr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:01 INFO - Running setup.py (path:/tmp/pip-uf7WgX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:01 INFO - Running setup.py (path:/tmp/pip-HStkYM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:01 INFO - Running setup.py (path:/tmp/pip-6hpzRP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:01 INFO - Running setup.py (path:/tmp/pip-wvHq8z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 08:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:01 INFO - Running setup.py (path:/tmp/pip-pK52oK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:08:02 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:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:02 INFO - Running setup.py (path:/tmp/pip-CEKTVu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:02 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:03 INFO - Downloading blessings-1.5.1.tar.gz 08:08:03 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:08:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:03 INFO - Installing collected packages: blessings 08:08:03 INFO - Running setup.py install for blessings 08:08:03 INFO - Successfully installed blessings 08:08:03 INFO - Cleaning up... 08:08:04 INFO - Return code: 0 08:08:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:08:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:08:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:08:04 INFO - Reading from file tmpfile_stdout 08:08:04 INFO - Current package versions: 08:08:04 INFO - argparse == 1.2.1 08:08:04 INFO - blessings == 1.5.1 08:08:04 INFO - blobuploader == 1.2.4 08:08:04 INFO - docopt == 0.6.1 08:08:04 INFO - manifestparser == 1.1 08:08:04 INFO - mozInstall == 1.12 08:08:04 INFO - mozcrash == 0.16 08:08:04 INFO - mozdebug == 0.1 08:08:04 INFO - mozdevice == 0.48 08:08:04 INFO - mozfile == 1.2 08:08:04 INFO - mozhttpd == 0.7 08:08:04 INFO - mozinfo == 0.9 08:08:04 INFO - mozleak == 0.1 08:08:04 INFO - mozlog == 3.1 08:08:04 INFO - moznetwork == 0.27 08:08:04 INFO - mozprocess == 0.22 08:08:04 INFO - mozprofile == 0.28 08:08:04 INFO - mozrunner == 6.11 08:08:04 INFO - mozscreenshot == 0.1 08:08:04 INFO - mozsystemmonitor == 0.0 08:08:04 INFO - moztest == 0.7 08:08:04 INFO - mozversion == 1.4 08:08:04 INFO - psutil == 3.1.1 08:08:04 INFO - requests == 1.2.3 08:08:04 INFO - wsgiref == 0.1.2 08:08:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:08:04 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:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 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:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 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 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:08:04 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:08:04 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:08:04 INFO - Using env: {'DISPLAY': ':0', 08:08:04 INFO - 'HOME': '/home/cltbld', 08:08:04 INFO - 'LANG': 'en_US.UTF-8', 08:08:04 INFO - 'LANGUAGE': 'en_US:en', 08:08:04 INFO - 'LOGNAME': 'cltbld', 08:08:04 INFO - 'MAIL': '/var/mail/cltbld', 08:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:04 INFO - 'MOZ_NO_REMOTE': '1', 08:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:04 INFO - 'NO_EM_RESTART': '1', 08:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:04 INFO - 'SHELL': '/bin/bash', 08:08:04 INFO - 'SHLVL': '1', 08:08:04 INFO - 'TERM': 'linux', 08:08:04 INFO - 'TMOUT': '86400', 08:08:04 INFO - 'USER': 'cltbld', 08:08:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:04 INFO - '_': '/tools/buildbot/bin/python'} 08:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 INFO - Cleaning up... 08:08:04 INFO - Return code: 0 08:08:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:08:04 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:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 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:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:04 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 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:08:04 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:08:04 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:08:04 INFO - Using env: {'DISPLAY': ':0', 08:08:04 INFO - 'HOME': '/home/cltbld', 08:08:04 INFO - 'LANG': 'en_US.UTF-8', 08:08:04 INFO - 'LANGUAGE': 'en_US:en', 08:08:04 INFO - 'LOGNAME': 'cltbld', 08:08:04 INFO - 'MAIL': '/var/mail/cltbld', 08:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:04 INFO - 'MOZ_NO_REMOTE': '1', 08:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:04 INFO - 'NO_EM_RESTART': '1', 08:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:04 INFO - 'SHELL': '/bin/bash', 08:08:04 INFO - 'SHLVL': '1', 08:08:04 INFO - 'TERM': 'linux', 08:08:04 INFO - 'TMOUT': '86400', 08:08:04 INFO - 'USER': 'cltbld', 08:08:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:04 INFO - '_': '/tools/buildbot/bin/python'} 08:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:04 INFO - Downloading/unpacking jsonschema 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:06 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:08:06 INFO - Downloading/unpacking functools32 (from jsonschema) 08:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:06 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:08:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:06 INFO - warning: no files found matching '*.txt' 08:08:06 INFO - no previously-included directories found matching 'build' 08:08:06 INFO - no previously-included directories found matching 'dist' 08:08:06 INFO - no previously-included directories found matching '.git*' 08:08:06 INFO - Installing collected packages: jsonschema, functools32 08:08:06 INFO - Running setup.py install for functools32 08:08:06 INFO - warning: no files found matching '*.txt' 08:08:06 INFO - no previously-included directories found matching 'build' 08:08:06 INFO - no previously-included directories found matching 'dist' 08:08:06 INFO - no previously-included directories found matching '.git*' 08:08:06 INFO - Successfully installed jsonschema functools32 08:08:06 INFO - Cleaning up... 08:08:06 INFO - Return code: 0 08:08:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962900f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2449480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', '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:08:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:08:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:08:06 INFO - Using env: {'DISPLAY': ':0', 08:08:06 INFO - 'HOME': '/home/cltbld', 08:08:06 INFO - 'LANG': 'en_US.UTF-8', 08:08:06 INFO - 'LANGUAGE': 'en_US:en', 08:08:06 INFO - 'LOGNAME': 'cltbld', 08:08:06 INFO - 'MAIL': '/var/mail/cltbld', 08:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:06 INFO - 'MOZ_NO_REMOTE': '1', 08:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:06 INFO - 'NO_EM_RESTART': '1', 08:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:06 INFO - 'SHELL': '/bin/bash', 08:08:06 INFO - 'SHLVL': '1', 08:08:06 INFO - 'TERM': 'linux', 08:08:06 INFO - 'TMOUT': '86400', 08:08:06 INFO - 'USER': 'cltbld', 08:08:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:06 INFO - '_': '/tools/buildbot/bin/python'} 08:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:07 INFO - Downloading/unpacking flake8 08:08:07 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:08:07 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:08:07 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:08:07 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:08:07 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:08:07 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:08:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:08:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:08:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:08:09 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:08:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:09 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:08:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:08:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:09 INFO - no previously-included directories found matching 'docs/_build' 08:08:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:08:09 INFO - Running setup.py install for pep8 08:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:08:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:08:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:08:09 INFO - no previously-included directories found matching 'docs/_build' 08:08:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:08:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:08:09 INFO - Cleaning up... 08:08:09 INFO - Return code: 0 08:08:09 INFO - Running post-action listener: _resource_record_post_action 08:08:09 INFO - Running post-action listener: _start_resource_monitoring 08:08:09 INFO - Starting resource monitoring. 08:08:09 INFO - ##### 08:08:09 INFO - ##### Running install step. 08:08:09 INFO - ##### 08:08:09 INFO - Running pre-action listener: _resource_record_pre_action 08:08:09 INFO - Running main action method: install 08:08:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:08:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:08:10 INFO - Reading from file tmpfile_stdout 08:08:10 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:08:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:08:10 INFO - Reading from file tmpfile_stdout 08:08:10 INFO - Output received: 08:08:10 INFO - Usage: mozinstall [options] installer 08:08:10 INFO - Options: 08:08:10 INFO - -h, --help show this help message and exit 08:08:10 INFO - -d DEST, --destination=DEST 08:08:10 INFO - Directory to install application into. [default: 08:08:10 INFO - "/builds/slave/test-pgo"] 08:08:10 INFO - --app=APP Application being installed. [default: firefox] 08:08:10 INFO - mkdir: /builds/slave/test-pgo/build/application 08:08:10 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:08:10 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:08:26 INFO - Reading from file tmpfile_stdout 08:08:26 INFO - Output received: 08:08:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:08:26 INFO - Running post-action listener: _resource_record_post_action 08:08:26 INFO - ##### 08:08:26 INFO - ##### Running run-tests step. 08:08:26 INFO - ##### 08:08:26 INFO - Running pre-action listener: _resource_record_pre_action 08:08:26 INFO - Running main action method: run_tests 08:08:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:08:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:08:26 INFO - Python 2.7.3 08:08:26 INFO - Return code: 0 08:08:26 INFO - grabbing minidump binary from tooltool 08:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:26 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 0x24d8660>, '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 0x24d9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:08:26 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:08:26 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:08:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:26 INFO - Return code: 0 08:08:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:08:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:08:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:08:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:08:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:08:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:08:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:08:27 INFO - Return code: 0 08:08:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:08:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:08:27 INFO - Using env: {'DISPLAY': ':0', 08:08:27 INFO - 'HOME': '/home/cltbld', 08:08:27 INFO - 'LANG': 'en_US.UTF-8', 08:08:27 INFO - 'LANGUAGE': 'en_US:en', 08:08:27 INFO - 'LOGNAME': 'cltbld', 08:08:27 INFO - 'MAIL': '/var/mail/cltbld', 08:08:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:08:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:27 INFO - 'MOZ_NO_REMOTE': '1', 08:08:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:27 INFO - 'NO_EM_RESTART': '1', 08:08:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:08:27 INFO - 'PWD': '/builds/slave/test-pgo', 08:08:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:08:27 INFO - 'SHELL': '/bin/bash', 08:08:27 INFO - 'SHLVL': '1', 08:08:27 INFO - 'TERM': 'linux', 08:08:27 INFO - 'TMOUT': '86400', 08:08:27 INFO - 'USER': 'cltbld', 08:08:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582', 08:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:27 INFO - '_': '/tools/buildbot/bin/python'} 08:08:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:08:27 INFO - mozversion application_buildid: 20160113053005 08:08:27 INFO - mozversion application_changeset: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 08:08:27 INFO - mozversion application_display_name: Nightly 08:08:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:27 INFO - mozversion application_name: Firefox 08:08:27 INFO - mozversion application_remotingname: firefox 08:08:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:27 INFO - mozversion application_vendor: Mozilla 08:08:27 INFO - mozversion application_version: 46.0a1 08:08:27 INFO - mozversion platform_buildid: 20160113053005 08:08:27 INFO - mozversion platform_changeset: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 08:08:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:27 INFO - mozversion platform_version: 46.0a1 08:08:27 INFO - using testdate: 1452701307 08:08:27 INFO - actual date: 1452701307 08:08:27 INFO - starting webserver on 'localhost:52107' 08:08:27 INFO - SUITE-START | Running 3 tests 08:08:27 INFO - TEST-START | dromaeo_css 08:08:27 INFO - operating with platform_type : linux_ 08:08:27 INFO - Initialising browser for dromaeo_css test... 08:08:27 INFO - TEST-INFO | started process 7152 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdgZUCe/profile http://localhost:52107/getInfo.html) 08:08:31 INFO - PROCESS | 7152 | __metrics Screen width/height:1600/1200 08:08:31 INFO - PROCESS | 7152 | colorDepth:24 08:08:31 INFO - PROCESS | 7152 | Browser inner width/height: 1024/697 08:08:31 INFO - PROCESS | 7152 | __metrics 08:08:31 INFO - PROCESS | 7152 | 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:08:31 INFO - PROCESS | 7152 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:32 INFO - TEST-INFO | 7152: exit 0 08:08:32 INFO - Browser initialized. 08:08:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:32 INFO - TEST-INFO | started process 7246 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdgZUCe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:44 INFO - PROCESS | 7246 | RSS: Main: 149815296 08:08:44 INFO - PROCESS | 7246 | 08:09:36 INFO - PROCESS | 7246 | 1452701376130 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:11:44 INFO - PROCESS | 7246 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52107/tests/dromaeo/cssquery-ext.html) 08:11:45 INFO - PROCESS | 7246 | RSS: Main: 267829248 08:11:45 INFO - PROCESS | 7246 | 08:14:47 INFO - PROCESS | 7246 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-ext.html (next: http://localhost:52107/tests/dromaeo/cssquery-jquery.html) 08:14:48 INFO - PROCESS | 7246 | RSS: Main: 230404096 08:14:48 INFO - PROCESS | 7246 | 08:17:50 INFO - PROCESS | 7246 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52107/tests/dromaeo/cssquery-mootools.html) 08:17:50 INFO - PROCESS | 7246 | RSS: Main: 231374848 08:17:50 INFO - PROCESS | 7246 | 08:20:52 INFO - PROCESS | 7246 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52107/tests/dromaeo/cssquery-prototype.html) 08:20:53 INFO - PROCESS | 7246 | RSS: Main: 211943424 08:20:53 INFO - PROCESS | 7246 | 08:23:55 INFO - PROCESS | 7246 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52107/tests/dromaeo/cssquery-yui.html) 08:23:56 INFO - PROCESS | 7246 | RSS: Main: 217366528 08:23:56 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-yui.html (next: http://localhost:52107/tests/dromaeo/cssquery-dojo.html) 08:26:59 INFO - PROCESS | 7246 | RSS: Main: 239079424 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | __start_tp_report 08:26:59 INFO - PROCESS | 7246 | _x_x_mozilla_page_load 08:26:59 INFO - PROCESS | 7246 | _x_x_mozilla_page_load_details 08:26:59 INFO - PROCESS | 7246 | |i|pagename|runs| 08:26:59 INFO - PROCESS | 7246 | |0;dojo.html;3166.1134882232977;3190.978886756239;3237.28779668473;3243.5459035735016;3266.0528446750436;5082.822101226458;5184.248283998822;5196.506331898473;5197.246399272103;5248.39643441004;5109.080365534202;5168.2764412982215;5178.067947769409;5198.168293073109;5209.453007434222;4659.440867095945;4685.1800934836265;4712.787924543387;4769.737664428455;4794.568488836004;4701.553352431513;4767.690100143497;4843.878903027435;4850.054239423313;4888.242322440027;4616.076784643051;4641.396618439615;4725;4773.379460670126;4789.473157952622;4734.124187025412;4760.23836186212;4768.976155119202;4773.809047638125;4779.091972525209;4725.125851717443;4730.692504987165;4741.57325840676;4743.217369134089;4767.737774422405;4884.19410797218;4965.329680493123;5033.496650334974;5051.318072060299;5074.112030394703;5570.637908535932;5577.8605534861545;5582.441755824426;5591.161325801162;5593.748281327309;5600.439956004367;5605;5628.774849006035;5630.380658127603;5630.8029218977135;5138.691678499302;5163.509466600704;5201.713905735183;5238.816641417532;5249.868753281198;5732.7706891723865;5734.369219385864;5734.39788822176;5739.253896993364;5742.626729262584;5511.53151982078;5520.337559492807;5527.170924361378;5531.751071201806;5534.75093620788;5480.534154596904;5545.417731138253;5566.526845218202;5599.384067752544;5647.830565083054;5450.236966824647;5458.6724796512335;5464.207689884945;5467.152591348347;5467.343918729698;5428.4842939920645;5447.101228297287;5447.264619276426;5449.073657478159;5501.889962200734;4303.827846886152;4322;4388.385626012361;4390.7585082820115;4399.274119770202;3845.8269377878064;3859.671927886161;3865.053061999828;3898.532176138825;3929.5677475477673;5179.352580927384;5191.922121168185;5207.531322181022;5218;5228.320318358589;5486.149646804752;5508.03609368359;5556.555475561945;5570.164475328733;5594.272744543265;5163.535281824654;5184.196449550326;5188.481151884781;5192.584593232532;5193.039287731782;4763.04739052191;4770.522947705202;4772.570468657837;4774.522547745267;4795.448523419851;5695.629784064023;5709.600327977085;5814.563907706939;5829.5336373090895;5878.088896221093;5472.808451704331;5473.890522189454;5477.123660214346;5478.397376288525;5481.232627432242;5635.0702134147405;5670.347909990404;5675;5688.544916406595;5700.714964251853;5476.315460567429;5490.286262785812;5520.944790552043;5527.53015993645;5570.91643625354;5554.194641776839;5572.136318870582;5604.551635869039;5613.158026296088;5615.971920140373;5404.432534583812;5487.506124448819;5493.7802487900035;5504.669719816824;5528.253685752372;5399.649022813504;5461.290032295935;5462.726863656881;5467.4532546745;5513.365962914316;5360.0619891518045;5390.784368625211;5400.513953744182;5401.216823560483;5453.127499600045;5313.123334649739;5346.97326513365;5402.567794576503;5485.61600687948;5512.035393806148;5340.439253878287;5382.784688612412;5406.24312596229;5411.918821217763;5419.918701219563 08:26:59 INFO - PROCESS | 7246 | |1;ext.html;518.3080587415802;531.1819797511832;536.7987004873172;543.2693027877503;592.7006861534927;27649.861750691245;27960;27960.58059129112;27989.440211195764;27998;28060.438791224162;28405.289867753316;35680.10799730008;36519.26961460769;36560.634393656124;8435.915640843605;8537.402381833273;8597.871031934526;8598;8601.397902146853;8340.207680270365;8469.534175620338;8475.872861907046;8482.872756908651;8485.151484851496;8478.152184781535;8522.531260780655;8541.871871921927;8562.914370856273;8563.186497282748;8614.267787238061;8669.869951950726;8691.652333906635;8711.651533938666;8713.607887645008;8487.193716596914;8593.656253749843;8618.78453038679;8625.956870215608;8628.827423451496;35926.46110308347;36016.45975310372;36210.09474763126;36226.275474490365;36261.45607815885;3189.4259033373983;3260.3805276997296;3276.770626056177;3591.102224443889;3756.624337566249;28912.710872891214;29327.12018639444;29525.114246572637;29567.40865182684;29709.40581188386;3806.71449641278;3809.733318667694;3829.812698222714;3834.482344883433;3922.7057970652313;266933;267417;268337;269064;269149;48934.510654893;54426.18360724593;54603.453965459834;54653.72673136609;54862.45137548653;44771.328430073576;44951.550484494735;44958;45001;60186.39813601896;13406.061575689608;13509.256990865597;13575.864241357658;13589.524366647318;13602.387892544859;10255.230857685703;10322.432266225429;10330.173586113093;10334.586616535405;10335.689929302132;16223.91888040576;16804.32782688703;18443.538911527317;18955.431337059912;19078.523036924187;7140.072570246278;7292.8176795579475;7393.186749457555;7459.962700186573;7465.141508726458;964.7491652170486;1014.3895992713136;1057.3867157048894;1061.9097376723066;1066.424130969268;27687.584686229722;28429.15708429182;28605;28892.85553572219;28924.855375722986;993.8558908958161;1030.0266248395344;1033.679559336608;1083.285031878956;1105.4804242006244;13404.664883377993;13433.865661343458;13468.5286014989;13620.318984050957;13660.043796934118;341358;341400;343416;343834;344084;48576;48865.511344886094;48878.26682599764;48911.51088489141;49100.263496047584;1288.0854593238905;1293.4438191577713;1317.960461186166;1322.3718733601654;1324.72843067171;23606;25391.36521586975;26957.865210673823;27053.59419608668;27271.318217044733;45944.54055459402;47820.521794781605;47825.521744782105;47844.521554784005;47911.5208847921;203517;203792;204284;204710;205169;27248.318792030357;27869.86065069743;30249.546256805726;30388.544171837;30594.235144121576;41209.38185927273;41502;41512.79243603763;41522.169556608096;42096.947576310835;29579.40841183207;29728.85135574308;32542.186445339055;32647.673523265414;33788.66211337855;28226.85886570554;33993.8102166423;34023.4896476558;34049.31901362009;34185.658143418244;29770.70229297679;31643.683563164075;31666;31672.366552668358;31688.04935851928;25390.866179369674;28794;31135.53296700506;33049.669503305624;34685.306293874484;23885.761142388354;23980.341035092282;24036.63945040861;24086.39784005414;24163.758362416855 08:26:59 INFO - PROCESS | 7246 | |2;jquery.html;359.1524003352089;363.9017465284372;364.5352175975631;365.62706039839367;365.77504834526775;13637.795433068488;13907.165570065803;15601.297941592627;16213.270402831871;17102;14698.63253418665;15393.769093463607;15792.605184870385;15817.683646327067;16593.83406165938;5223.112070947948;5410.242566040757;5414.675119492843;5421.647592906468;5422.810201642943;3932.2135572885395;4060.0255938574824;5221.451747566508;5349.8127565535215;5543.889122217553;5663.4336566343445;5694.544436445074;5716.971415142939;5717.828465146053;5729.598928075036;5108.412532558747;5285.577153827685;5294.311739473882;5315.176147697113;5317.335333083345;4826.7827947742435;5008.54923056923;5013.323201367805;5019.749012549358;5099.33708617881;12028.398580070962;12324.445399957023;12605.180663256859;12616.558420455332;12631.178973366701;2009.5076706206926;2053.301877361704;2094.2984100326407;2143.7749036351115;2157.061678170001;11826.662203146761;11845.111616628787;12261.754764904741;12681.112322137455;13042.86957130426;1769.5664562182349;1808.728690696393;1817.3548390321378;1868.953276168093;1876.2213681322235;55426.44573554293;55890;56595.43404565943;57363.71318143424;58162.836743264896;9716.854247186298;10129.290949633601;10145.746356341151;10150.390976541432;10251.948740256252;13366.730160634725;13576.796348054788;13585.59243222705;13598.660033499242;13626.454941802414;7239.855202895913;7253.455990800711;7253.782386528413;7309.122905251404;7376.262373762581;6853.623050732158;6890.276520965327;6927.653617319113;6955.061066756024;6968.58188508681;4406.933895991563;4483.3723278741;4499.055198408371;4520.344550040291;4521.0279789845345;1706.906120163378;1767.2489192093567;1768.7170052791748;1791.8208179182238;1812.1301775148004;447.78953891670864;449.9662525310549;452.36894532127496;461.28040257198876;926.7961048569304;10442.2168337375;10457.790844183073;10517.737056573647;10524.631637892637;10739.35563866155;452.9139463501924;467.0518846741121;478.6840685147855;480.04710649360993;493.54158461745453;5745.569082318842;5840.386759390203;5861.501772349313;5980.611260268069;5997;358208;540912;548306.1016339032;557106;558307;54995;61950;62166.0675089874;64777;71513.6424317875;474.3374472473957;483.014650113771;483.78713366118797;484.2059023201881;484.5566306829212;9867.273227185071;10193.133583645176;11146.721331966766;13687.31563421805;13906.58280251594;29959.550606740482;30161.245968850955;31538.211544711565;32266.516002259516;33695.3260934775;39953.20093598054;40617.39073913835;40663.18673626452;42117;42210.36684449674;6854.868946623751;7136.714531418893;7177.282271772781;7229.385502232369;7505.249475052669;10303.896961030594;10813.729656758644;11416.429178540873;11536.480858361227;11596.942015290208;9458.716238512856;9902.405855648683;10020.749481263027;10109.545070471699;10282.07461328484;9678.95160524193;9902.801943961225;10109.49452527356;10174.389536627827;10438.269321147447;8660.350473714623;9787.021297870157;9827.55775990068;10032.69901902944;10092.091711745978;7137.82155446118;7262.9273707262255;7290.635468226674;7347.669354878936;7390.150132734804;8438.071812100541;8950.68672596456;9831.85252221203;9893.950530247303;10146.746331341776 08:26:59 INFO - PROCESS | 7246 | |3;mootools.html;1294.2816736711134;1453.048253394027;1469.8750606198469;1606.3574570171936;1771.840534351908;6822.488313376498;7308.196098429168;7420.814479637998;7422.851542969137;7432.554046757198;7331.156916954552;7508.511946723459;7513.135989361212;7519.962400187991;7522.134954480236;1939.9127039283267;1941.417574727583;1949.0449679656938;2286.702728645274;2340.32130682102;2027.6248893954667;2288.8969996350206;2340.3681006128336;2344.660024296476;2345.061975209913;2185.25701261571;2197.165077270643;2203.5152266501423;2208.7791220877943;2256.277991042867;2267.943301417461;2271.0915633746467;2275.419767959176;2283.041122728458;2283.246528645543;2274.3972847195505;2306.042992158252;2306.8385213035094;2308.3882771065682;2323.1984965187153;7601.201873803282;7668.539887606761;7671.693132274702;7672;7674.808129796744;4741.502142275046;4810.470848206694;4847.587955023827;4850.272459131159;4854.17479028566;3007.6090108286003;3141.0419821954297;3154.779165458419;3162.4940009598586;3178.96821031789;975.0493269062678;997.6607953295915;1007.7027276953243;1008.9747756306151;1030.258214085857;10416.375017498975;10584.947075264652;10594.523246453928;10599.89400105989;10600;4389.736615803062;4421.42521472213;4455.04216593434;4479.7984090716;4484.372187893698;9163.679271225476;9216.63133474667;9222.262219022463;9222.40054396462;9225.861612075823;4839.395075615548;4848;4879.56083952446;4886.486918873538;4889.633277504201;4408.6913916026215;4412.514623391425;4417.690761646654;4420.447444069491;4422.226110430662;3393.813340266309;3554.360215161296;3602.4056030755155;3648.6533779290926;3649.251903359805;1116.5812820192427;1175.371176420611;1202.6692659518528;1220.8657047724744;1222.034592671797;1257.9245245285313;1280.481405030964;1301.3103055380664;1304.804279358104;1306.1510018487868;6796.388325050671;6960.060391847036;6972;6975.162980442278;6976.476764242702;1080.2600218850114;1085.2132204152085;1104.2987702808775;1112.6828853776635;1115.587232723881;5548.167774833807;5663.9716801415725;5669.574781891375;5736.282964629421;5764.279465066867;8998.59506322217;9091.27269818413;9445.291603129794;9451.905480945103;9456.952715236379;9222.95388523053;9291.58187881547;9308.255339572817;9342.346035777566;9352.111549402796;6816.556923799937;6944.992976018449;7003.6848341823725;7125.714971401086;7310.378617817439;7061.823454413475;7185.604791736505;7187.6765545551625;7194.676239569128;7195.244499327705;7966.402519811153;8054.798630034296;8072.878906816285;8072.919270807217;8191.262786349257;8311.293540049164;8474.152584741476;8475.533845638549;8654.956725216334;8670.306375490072;6753.223379311442;6762.932370676427;6779.35596118368;6783.89824152648;6792;6500.674966251763;6662.966685166543;7288.672009759467;7401.777946661608;7426.18311985692;6765.357291057342;6811.5231933766145;6885.070515480546;6996.545224560387;7002.0547226125855;6663.600183988976;6736.797896063126;6739.224989126314;6797.694103765243;6893.20728116253;6702.83242918931;6748.7300507979135;6761.594304341756;6762.019507171531;6764.492663050192;6285.685715714105;6317.30509643948;6322;6361.2048493938255;6362.491000719839;6034.24571928509;6193.690315484298;6215.564910456405;6309;6310.936890631035 08:26:59 INFO - PROCESS | 7246 | |4;prototype.html;341.3190684584255;348.78898266548737;349.882789265596;352.89589571076544;353.0238889470613;5734.655920644765;5761.884762304751;5767.4809267166;5770.884582308351;5775.451332123452;5488.4785945335125;5556.277683901088;5621.690807005613;5683.460071293221;5707.115397113444;4407.2948328267485;4438.267685831842;4441.067375851075;4451.999999999984;4460.643148548124;4348.152110338485;4451.465824101097;4453.576910193527;4455.84404545841;4465.5311192324825;4367.912641747163;4401.581849724287;4471.575200355961;4491.348754430605;4501.729896206221;4446.888827779299;4478.350639157336;4483.865484035484;4489.4612646482465;4491.348754430605;3984.242993831163;3988.062805240766;3989.7007724420782;3991.501062367204;3994.2810294147334;5481.342238931314;5565.41563135873;5575.609707320489;5580.581456390787;5589.217509548666;5218.791248350061;5231.136862417697;5232.7122008289525;5234.42421333653;5236.057509648262;6111.083337499366;6119.143319935168;6119.357467465897;6120.234970628671;6121.051237058218;4424.491183513905;4425.09285596452;4428.446444194476;4430.246858034142;4443.155800397946;6244.656543890084;6401.711922963478;6406.775762848324;6456.192975878015;6477.190351206099;4524.660650451229;4529.048899731028;4531.365608814768;4535.501094879626;4550.067236216568;4598.172328980816;4600.194965880957;4600.631949444037;4600.7929643166135;4603.631709463235;5219.347581552306;5219.608529360313;5220.660657057279;5222.2427747976335;5228.2941802856885;6038.33578306386;6139.57023008394;6155.938440615626;6162.044883043135;6167.629942203482;1599.3682495414246;1621.8621417179672;1622.5456872075838;1622.9188540573161;1623.6914986152594;1102.7022703869911;1114.3202646385698;1116.3023110555903;1118.0440723181562;1136.4545018391218;5813.069908814569;5819.6508209507565;5821.097729851795;5827.854303642358;5827.9509688255675;6238.313785483593;6247;6294.874102517924;6298.181236439325;6309.337519560472;5667.773289068474;5671.914921276184;5783.797567085216;5794.971025144847;5846.386129456431;3380.712639425627;3394.3890099782275;3402.1834759657504;3402.8468718907707;3406.1144102533026;6457.418832305115;6494.447971922439;6507.479401647857;6513.153290072355;6653.334666533308;6387.520935929824;6499.2200935887995;6500.187476565429;6532.5753826001155;6541.574797638234;6582.934170658328;6618.437432818168;6661.16735408074;6665.566738162101;6666.466682665375;6325.77859774924;6334.904976425265;6340.841478963062;6341.841453963688;6343.207099112611;6122.142899994094;6256.655883926245;6260.248770147429;6269.811905642838;6273.498120150468;6580.078788969452;6586.407223349922;6587.374199451045;6589.703463344257;6592.17597800275;4483.14820184164;4486.730796152241;4491.48347939978;4497.662675299301;4501.482329532146;6247.625142491465;6301.527385446018;6359.3640635936035;6364.554481186273;6365.52258580599;6194.101855231056;6201.472874805692;6203.472704820141;6210.347913469021;6210.503159747119;6201.255849298113;6201.286852012076;6210.441060304594;6212.658303793335;6218.347073557211;5968.253968253968;6054.061620448838;6072.14989901423;6079.908801367895;6092.817215483543;6222.968885155546;6228.4705800007505;6229.314775374614;6233.532485063548;6237.095621135;6045.21412216409;6079.148919151411;6082.695865206811;6087.66517841523;6089.360617135137 08:26:59 INFO - PROCESS | 7246 | |5;yui.html;755.2560727683231;755.4862693368509;804.981698151838;818.4679958027277;841.7138173021171;12590.307533085677;12754;12801.871981280185;12835.807462888053;12864.09951303409;11655.242409243414;11876.881231187686;11938.880611193885;11967.281963082221;11994.100442466806;814.0963530481176;820.7004443378154;821.6918655504186;821.765796747927;822.0587427395628;682.0485422835142;686.2177118085361;809.9271065604095;821.2280456370992;823.8352329534088;848.9235968762811;854.8375808596347;856.3021137772695;857.2670366836359;857.7984173719202;705.5061456980084;711.249631638621;854.7136709202425;856.7386946981168;856.9185927336924;524.0750076115659;524.9816256431045;524.9842504724826;607.9179310793074;636.7134789344814;12106.092043096714;12113.93943030288;12118.757624847542;12118.939405302917;12131.150819442642;11630.825537616942;12133.817992730115;12183.238302741975;12284.754304913851;12287.077900033937;9549.47477888716;9655.758606034906;9698.9515052425;9910.801783964353;9983.950080249553;3558.1460449491938;3628;3636.5272514572935;3706.2031663192543;3708.888733337977;46346;46512.53487465116;46530.76734616339;46693.76653116713;46720;8700.390972631854;8909.1536304051;9120.8631870522;9179.082091790768;9227.44635321883;16403.91798041002;16511.669766604842;16546.91726541384;16558.503244902673;16580.336786528405;6940.757073502504;7250.456215783732;7364.22675619063;7368.410527157815;7420.369268612229;4164.83340666376;4243.42713733642;4299.226139294957;4317.676174286941;4325.9134817303475;2921.956170657442;2955.6305461817274;2995.05655718448;3016.7888247822443;3026.3644634626535;603.7283222549783;606.5693357715983;611.5321778839192;611.5566214494545;625.2340882419091;551.6000899348021;620.3052581109187;623.7442648514087;623.9766782476742;657.8486948001986;7562.773116806505;7926.762197134095;8079.232472915063;8131.416429044223;8200.548969806718;572.1646396261422;625.5371025441141;643.6363454648109;671.3689132215702;679.3206793206793;3707.4994875691978;3770.698344132463;4011.1777085697363;4215.536291007987;4243.172581346607;54441;55961.440385596434;56042.71978640162;56073;56436.435635643116;48552.5144748548;50123.74938125286;50579;50734.238986415236;51271.48728512742;42358.57641423608;42867.35698964518;43227.35158972618;45931.77034114808;46057.30914036292;7736.8242501646255;7980.201979801974;8084.595770211348;8188.590570471333;8246.711365102192;33196.1700957478;33347.666523334454;34133.31733365269;34697;34967;39551.2089758209;39599.40600890931;43669;43723.34414983714;44130;10293.639722609672;10295.742606434898;10414.895851041696;10939.124870010539;11445.599404020819;11033.889661103607;11205.887941120485;11245.212835101463;11310.321380717183;11369.204155709022;10511.632092876713;10548.419836909045;11042.061424778662;11203.103751699682;11261.21171517986;10877.564897404016;10887.129029677448;10924;10930.180236482454;11292.573981016283;10430.26988110825;10655.14758819277;10736.731581710208;11048.834267485834;11083.279586826831;8826.735197944072;9092.818143637223;9311.301652375963;9325.720228393158;9343.906560934303;8836.293096552388;8944.910550894669;8955.507447090473;9799.11807937289;10010.299279050396 08:26:59 INFO - PROCESS | 7246 | __end_tp_report 08:26:59 INFO - PROCESS | 7246 | __start_cc_report 08:26:59 INFO - PROCESS | 7246 | _x_x_mozilla_cycle_collect,988 08:26:59 INFO - PROCESS | 7246 | __end_cc_report 08:26:59 INFO - PROCESS | 7246 | __startTimestamp1452702419271__endTimestamp 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | ------- Summary: start ------- 08:26:59 INFO - PROCESS | 7246 | Number of tests: 6 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | [#0] dojo.html Cycles:165 Average:5170.18 Median:5400.51 stddev:549.36 (10.2%) stddev-sans-first:528.07 08:26:59 INFO - PROCESS | 7246 | Values: 3166.1 3191.0 3237.3 3243.5 3266.1 5082.8 5184.2 5196.5 5197.2 5248.4 5109.1 5168.3 5178.1 5198.2 5209.5 4659.4 4685.2 4712.8 4769.7 4794.6 4701.6 4767.7 4843.9 4850.1 4888.2 4616.1 4641.4 4725.0 4773.4 4789.5 4734.1 4760.2 4769.0 4773.8 4779.1 4725.1 4730.7 4741.6 4743.2 4767.7 4884.2 4965.3 5033.5 5051.3 5074.1 5570.6 5577.9 5582.4 5591.2 5593.7 5600.4 5605.0 5628.8 5630.4 5630.8 5138.7 5163.5 5201.7 5238.8 5249.9 5732.8 5734.4 5734.4 5739.3 5742.6 5511.5 5520.3 5527.2 5531.8 5534.8 5480.5 5545.4 5566.5 5599.4 5647.8 5450.2 5458.7 5464.2 5467.2 5467.3 5428.5 5447.1 5447.3 5449.1 5501.9 4303.8 4322.0 4388.4 4390.8 4399.3 3845.8 3859.7 3865.1 3898.5 3929.6 5179.4 5191.9 5207.5 5218.0 5228.3 5486.1 5508.0 5556.6 5570.2 5594.3 5163.5 5184.2 5188.5 5192.6 5193.0 4763.0 4770.5 4772.6 4774.5 4795.4 5695.6 5709.6 5814.6 5829.5 5878.1 5472.8 5473.9 5477.1 5478.4 5481.2 5635.1 5670.3 5675.0 5688.5 5700.7 5476.3 5490.3 5520.9 5527.5 5570.9 5554.2 5572.1 5604.6 5613.2 5616.0 5404.4 5487.5 5493.8 5504.7 5528.3 5399.6 5461.3 5462.7 5467.5 5513.4 5360.1 5390.8 5400.5 5401.2 5453.1 5313.1 5347.0 5402.6 5485.6 5512.0 5340.4 5382.8 5406.2 5411.9 5419.9 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | [#1] ext.html Cycles:180 Average:42558.32 Median:18163.22 stddev:72814.14 (400.9%) stddev-sans-first:72949.99 08:26:59 INFO - PROCESS | 7246 | Values: 518.3 531.2 536.8 543.3 592.7 27649.9 27960.0 27960.6 27989.4 27998.0 28060.4 28405.3 35680.1 36519.3 36560.6 8435.9 8537.4 8597.9 8598.0 8601.4 8340.2 8469.5 8475.9 8482.9 8485.2 8478.2 8522.5 8541.9 8562.9 8563.2 8614.3 8669.9 8691.7 8711.7 8713.6 8487.2 8593.7 8618.8 8626.0 8628.8 35926.5 36016.5 36210.1 36226.3 36261.5 3189.4 3260.4 3276.8 3591.1 3756.6 28912.7 29327.1 29525.1 29567.4 29709.4 3806.7 3809.7 3829.8 3834.5 3922.7 266933.0 267417.0 268337.0 269064.0 269149.0 48934.5 54426.2 54603.5 54653.7 54862.5 44771.3 44951.6 44958.0 45001.0 60186.4 13406.1 13509.3 13575.9 13589.5 13602.4 10255.2 10322.4 10330.2 10334.6 10335.7 16223.9 16804.3 18443.5 18955.4 19078.5 7140.1 7292.8 7393.2 7460.0 7465.1 964.7 1014.4 1057.4 1061.9 1066.4 27687.6 28429.2 28605.0 28892.9 28924.9 993.9 1030.0 1033.7 1083.3 1105.5 13404.7 13433.9 13468.5 13620.3 13660.0 341358.0 341400.0 343416.0 343834.0 344084.0 48576.0 48865.5 48878.3 48911.5 49100.3 1288.1 1293.4 1318.0 1322.4 1324.7 23606.0 25391.4 26957.9 27053.6 27271.3 45944.5 47820.5 47825.5 47844.5 47911.5 203517.0 203792.0 204284.0 204710.0 205169.0 27248.3 27869.9 30249.5 30388.5 30594.2 41209.4 41502.0 41512.8 41522.2 42096.9 29579.4 29728.9 32542.2 32647.7 33788.7 28226.9 33993.8 34023.5 34049.3 34185.7 29770.7 31643.7 31666.0 31672.4 31688.0 25390.9 28794.0 31135.5 33049.7 34685.3 23885.8 23980.3 24036.6 24086.4 24163.8 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | [#2] jquery.html Cycles:180 Average:25824.06 Median:452.64 stddev:84705.80 (18713.7%) stddev-sans-first:84921.84 08:26:59 INFO - PROCESS | 7246 | Values: 359.2 363.9 364.5 365.6 365.8 13637.8 13907.2 15601.3 16213.3 17102.0 14698.6 15393.8 15792.6 15817.7 16593.8 5223.1 5410.2 5414.7 5421.6 5422.8 3932.2 4060.0 5221.5 5349.8 5543.9 5663.4 5694.5 5717.0 5717.8 5729.6 5108.4 5285.6 5294.3 5315.2 5317.3 4826.8 5008.5 5013.3 5019.7 5099.3 12028.4 12324.4 12605.2 12616.6 12631.2 2009.5 2053.3 2094.3 2143.8 2157.1 11826.7 11845.1 12261.8 12681.1 13042.9 1769.6 1808.7 1817.4 1869.0 1876.2 55426.4 55890.0 56595.4 57363.7 58162.8 9716.9 10129.3 10145.7 10150.4 10251.9 13366.7 13576.8 13585.6 13598.7 13626.5 7239.9 7253.5 7253.8 7309.1 7376.3 6853.6 6890.3 6927.7 6955.1 6968.6 4406.9 4483.4 4499.1 4520.3 4521.0 1706.9 1767.2 1768.7 1791.8 1812.1 447.8 450.0 452.4 461.3 926.8 10442.2 10457.8 10517.7 10524.6 10739.4 452.9 467.1 478.7 480.0 493.5 5745.6 5840.4 5861.5 5980.6 5997.0 358208.0 540912.0 548306.1 557106.0 558307.0 54995.0 61950.0 62166.1 64777.0 71513.6 474.3 483.0 483.8 484.2 484.6 9867.3 10193.1 11146.7 13687.3 13906.6 29959.6 30161.2 31538.2 32266.5 33695.3 39953.2 40617.4 40663.2 42117.0 42210.4 6854.9 7136.7 7177.3 7229.4 7505.2 10303.9 10813.7 11416.4 11536.5 11596.9 9458.7 9902.4 10020.7 10109.5 10282.1 9679.0 9902.8 10109.5 10174.4 10438.3 8660.4 9787.0 9827.6 10032.7 10092.1 7137.8 7262.9 7290.6 7347.7 7390.2 8438.1 8950.7 9831.9 9894.0 10146.7 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | [#3] mootools.html Cycles:180 Average:5374.08 Median:6250.63 stddev:2750.45 (44.0%) stddev-sans-first:2741.06 08:26:59 INFO - PROCESS | 7246 | Values: 1294.3 1453.0 1469.9 1606.4 1771.8 6822.5 7308.2 7420.8 7422.9 7432.6 7331.2 7508.5 7513.1 7520.0 7522.1 1939.9 1941.4 1949.0 2286.7 2340.3 2027.6 2288.9 2340.4 2344.7 2345.1 2185.3 2197.2 2203.5 2208.8 2256.3 2267.9 2271.1 2275.4 2283.0 2283.2 2274.4 2306.0 2306.8 2308.4 2323.2 7601.2 7668.5 7671.7 7672.0 7674.8 4741.5 4810.5 4847.6 4850.3 4854.2 3007.6 3141.0 3154.8 3162.5 3179.0 975.0 997.7 1007.7 1009.0 1030.3 10416.4 10584.9 10594.5 10599.9 10600.0 4389.7 4421.4 4455.0 4479.8 4484.4 9163.7 9216.6 9222.3 9222.4 9225.9 4839.4 4848.0 4879.6 4886.5 4889.6 4408.7 4412.5 4417.7 4420.4 4422.2 3393.8 3554.4 3602.4 3648.7 3649.3 1116.6 1175.4 1202.7 1220.9 1222.0 1257.9 1280.5 1301.3 1304.8 1306.2 6796.4 6960.1 6972.0 6975.2 6976.5 1080.3 1085.2 1104.3 1112.7 1115.6 5548.2 5664.0 5669.6 5736.3 5764.3 8998.6 9091.3 9445.3 9451.9 9457.0 9223.0 9291.6 9308.3 9342.3 9352.1 6816.6 6945.0 7003.7 7125.7 7310.4 7061.8 7185.6 7187.7 7194.7 7195.2 7966.4 8054.8 8072.9 8072.9 8191.3 8311.3 8474.2 8475.5 8655.0 8670.3 6753.2 6762.9 6779.4 6783.9 6792.0 6500.7 6663.0 7288.7 7401.8 7426.2 6765.4 6811.5 6885.1 6996.5 7002.1 6663.6 6736.8 6739.2 6797.7 6893.2 6702.8 6748.7 6761.6 6762.0 6764.5 6285.7 6317.3 6322.0 6361.2 6362.5 6034.2 6193.7 6215.6 6309.0 6310.9 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | [#4] prototype.html Cycles:180 Average:5170.33 Median:5773.17 stddev:1524.14 (26.4%) stddev-sans-first:1484.69 08:26:59 INFO - PROCESS | 7246 | Values: 341.3 348.8 349.9 352.9 353.0 5734.7 5761.9 5767.5 5770.9 5775.5 5488.5 5556.3 5621.7 5683.5 5707.1 4407.3 4438.3 4441.1 4452.0 4460.6 4348.2 4451.5 4453.6 4455.8 4465.5 4367.9 4401.6 4471.6 4491.3 4501.7 4446.9 4478.4 4483.9 4489.5 4491.3 3984.2 3988.1 3989.7 3991.5 3994.3 5481.3 5565.4 5575.6 5580.6 5589.2 5218.8 5231.1 5232.7 5234.4 5236.1 6111.1 6119.1 6119.4 6120.2 6121.1 4424.5 4425.1 4428.4 4430.2 4443.2 6244.7 6401.7 6406.8 6456.2 6477.2 4524.7 4529.0 4531.4 4535.5 4550.1 4598.2 4600.2 4600.6 4600.8 4603.6 5219.3 5219.6 5220.7 5222.2 5228.3 6038.3 6139.6 6155.9 6162.0 6167.6 1599.4 1621.9 1622.5 1622.9 1623.7 1102.7 1114.3 1116.3 1118.0 1136.5 5813.1 5819.7 5821.1 5827.9 5828.0 6238.3 6247.0 6294.9 6298.2 6309.3 5667.8 5671.9 5783.8 5795.0 5846.4 3380.7 3394.4 3402.2 3402.8 3406.1 6457.4 6494.4 6507.5 6513.2 6653.3 6387.5 6499.2 6500.2 6532.6 6541.6 6582.9 6618.4 6661.2 6665.6 6666.5 6325.8 6334.9 6340.8 6341.8 6343.2 6122.1 6256.7 6260.2 6269.8 6273.5 6580.1 6586.4 6587.4 6589.7 6592.2 4483.1 4486.7 4491.5 4497.7 4501.5 6247.6 6301.5 6359.4 6364.6 6365.5 6194.1 6201.5 6203.5 6210.3 6210.5 6201.3 6201.3 6210.4 6212.7 6218.3 5968.3 6054.1 6072.1 6079.9 6092.8 6223.0 6228.5 6229.3 6233.5 6237.1 6045.2 6079.1 6082.7 6087.7 6089.4 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - PROCESS | 7246 | [#5] yui.html Cycles:180 Average:13189.29 Median:47636.26 stddev:15399.59 (32.3%) stddev-sans-first:15414.48 08:26:59 INFO - PROCESS | 7246 | Values: 755.3 755.5 805.0 818.5 841.7 12590.3 12754.0 12801.9 12835.8 12864.1 11655.2 11876.9 11938.9 11967.3 11994.1 814.1 820.7 821.7 821.8 822.1 682.0 686.2 809.9 821.2 823.8 848.9 854.8 856.3 857.3 857.8 705.5 711.2 854.7 856.7 856.9 524.1 525.0 525.0 607.9 636.7 12106.1 12113.9 12118.8 12118.9 12131.2 11630.8 12133.8 12183.2 12284.8 12287.1 9549.5 9655.8 9699.0 9910.8 9984.0 3558.1 3628.0 3636.5 3706.2 3708.9 46346.0 46512.5 46530.8 46693.8 46720.0 8700.4 8909.2 9120.9 9179.1 9227.4 16403.9 16511.7 16546.9 16558.5 16580.3 6940.8 7250.5 7364.2 7368.4 7420.4 4164.8 4243.4 4299.2 4317.7 4325.9 2922.0 2955.6 2995.1 3016.8 3026.4 603.7 606.6 611.5 611.6 625.2 551.6 620.3 623.7 624.0 657.8 7562.8 7926.8 8079.2 8131.4 8200.5 572.2 625.5 643.6 671.4 679.3 3707.5 3770.7 4011.2 4215.5 4243.2 54441.0 55961.4 56042.7 56073.0 56436.4 48552.5 50123.7 50579.0 50734.2 51271.5 42358.6 42867.4 43227.4 45931.8 46057.3 7736.8 7980.2 8084.6 8188.6 8246.7 33196.2 33347.7 34133.3 34697.0 34967.0 39551.2 39599.4 43669.0 43723.3 44130.0 10293.6 10295.7 10414.9 10939.1 11445.6 11033.9 11205.9 11245.2 11310.3 11369.2 10511.6 10548.4 11042.1 11203.1 11261.2 10877.6 10887.1 10924.0 10930.2 11292.6 10430.3 10655.1 10736.7 11048.8 11083.3 8826.7 9092.8 9311.3 9325.7 9343.9 8836.3 8944.9 8955.5 9799.1 10010.3 08:26:59 INFO - PROCESS | 7246 | -------- Summary: end -------- 08:26:59 INFO - PROCESS | 7246 | 08:26:59 INFO - TEST-INFO | 7246: exit 0 08:26:59 INFO - TEST-OK | dromaeo_css | took 1112577ms 08:26:59 INFO - TEST-START | kraken 08:26:59 INFO - operating with platform_type : linux_ 08:26:59 INFO - Initialising browser for kraken test... 08:26:59 INFO - TEST-INFO | started process 7441 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLcsqvW/profile http://localhost:52107/getInfo.html) 08:27:03 INFO - PROCESS | 7441 | __metrics Screen width/height:1600/1200 08:27:03 INFO - PROCESS | 7441 | colorDepth:24 08:27:03 INFO - PROCESS | 7441 | Browser inner width/height: 1024/697 08:27:03 INFO - PROCESS | 7441 | __metrics 08:27:03 INFO - PROCESS | 7441 | 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:27:03 INFO - PROCESS | 7441 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:05 INFO - TEST-INFO | 7441: exit 0 08:27:05 INFO - Browser initialized. 08:27:05 INFO - Running cycle 1/1 for kraken test... 08:27:05 INFO - TEST-INFO | started process 7527 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLcsqvW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:16 INFO - PROCESS | 7527 | RSS: Main: 150716416 08:27:16 INFO - PROCESS | 7527 | 08:27:19 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52107/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:19 INFO - PROCESS | 7527 | RSS: Main: 189202432 08:27:19 INFO - PROCESS | 7527 | 08:27:22 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52107/tests/kraken/driver.html?testName=audio-dft) 08:27:23 INFO - PROCESS | 7527 | RSS: Main: 179261440 08:27:23 INFO - PROCESS | 7527 | 08:27:26 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52107/tests/kraken/driver.html?testName=audio-fft) 08:27:26 INFO - PROCESS | 7527 | RSS: Main: 163045376 08:27:26 INFO - PROCESS | 7527 | 08:27:28 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52107/tests/kraken/driver.html?testName=audio-oscillator) 08:27:29 INFO - PROCESS | 7527 | RSS: Main: 164184064 08:27:29 INFO - PROCESS | 7527 | 08:27:31 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:31 INFO - PROCESS | 7527 | RSS: Main: 165842944 08:27:31 INFO - PROCESS | 7527 | 08:27:34 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52107/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:35 INFO - PROCESS | 7527 | RSS: Main: 165617664 08:27:35 INFO - PROCESS | 7527 | 08:27:38 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52107/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:39 INFO - PROCESS | 7527 | RSS: Main: 168148992 08:27:39 INFO - PROCESS | 7527 | 08:27:42 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52107/tests/kraken/driver.html?testName=json-parse-financial) 08:27:42 INFO - PROCESS | 7527 | RSS: Main: 167690240 08:27:42 INFO - PROCESS | 7527 | 08:27:44 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:44 INFO - PROCESS | 7527 | RSS: Main: 176824320 08:27:44 INFO - PROCESS | 7527 | 08:27:46 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:47 INFO - PROCESS | 7527 | RSS: Main: 174927872 08:27:47 INFO - PROCESS | 7527 | 08:27:49 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:27:49 INFO - PROCESS | 7527 | RSS: Main: 186945536 08:27:49 INFO - PROCESS | 7527 | 08:27:52 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:27:52 INFO - PROCESS | 7527 | RSS: Main: 193630208 08:27:52 INFO - PROCESS | 7527 | 08:27:55 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:27:55 INFO - PROCESS | 7527 | RSS: Main: 192446464 08:27:55 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52107/tests/kraken/driver.html?testName=ai-astar) 08:27:57 INFO - PROCESS | 7527 | RSS: Main: 249327616 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | __start_tp_report 08:27:57 INFO - PROCESS | 7527 | _x_x_mozilla_page_load 08:27:57 INFO - PROCESS | 7527 | _x_x_mozilla_page_load_details 08:27:57 INFO - PROCESS | 7527 | |i|pagename|runs| 08:27:57 INFO - PROCESS | 7527 | |0;ai-astar;109;111;106;111;110;110;100;109;109;109 08:27:57 INFO - PROCESS | 7527 | |1;audio-beat-detection;156;125;155;182;127;148;149;124;166;128 08:27:57 INFO - PROCESS | 7527 | |2;audio-dft;168;161;160;162;161;159;160;161;163;161 08:27:57 INFO - PROCESS | 7527 | |3;audio-fft;72;75;97;97;81;72;72;114;98;73 08:27:57 INFO - PROCESS | 7527 | |4;audio-oscillator;96;96;158;95;95;96;139;95;96;137 08:27:57 INFO - PROCESS | 7527 | |5;imaging-gaussian-blur;109;110;109;109;109;109;109;109;110;109 08:27:57 INFO - PROCESS | 7527 | |6;imaging-darkroom;145;147;145;147;145;146;146;146;145;146 08:27:57 INFO - PROCESS | 7527 | |7;imaging-desaturate;96;96;96;95;96;95;96;96;95;95 08:27:57 INFO - PROCESS | 7527 | |8;json-parse-financial;58;56;56;55;55;55;57;66;53;54 08:27:57 INFO - PROCESS | 7527 | |9;json-stringify-tinderbox;67;67;67;67;68;68;67;66;67;68 08:27:57 INFO - PROCESS | 7527 | |10;stanford-crypto-aes;81;80;81;89;82;81;82;82;83;88 08:27:57 INFO - PROCESS | 7527 | |11;stanford-crypto-ccm;116;129;114;122;111;116;121;112;121;114 08:27:57 INFO - PROCESS | 7527 | |12;stanford-crypto-pbkdf2;142;141;145;141;152;133;143;141;142;142 08:27:57 INFO - PROCESS | 7527 | |13;stanford-crypto-sha256-iterative;67;67;75;68;65;67;65;69;66;68 08:27:57 INFO - PROCESS | 7527 | __end_tp_report 08:27:57 INFO - PROCESS | 7527 | __start_cc_report 08:27:57 INFO - PROCESS | 7527 | _x_x_mozilla_cycle_collect,937 08:27:57 INFO - PROCESS | 7527 | __end_cc_report 08:27:57 INFO - PROCESS | 7527 | __startTimestamp1452702477765__endTimestamp 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | ------- Summary: start ------- 08:27:57 INFO - PROCESS | 7527 | Number of tests: 14 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.50 stddev:3.27 (3.0%) stddev-sans-first:3.46 08:27:57 INFO - PROCESS | 7527 | Values: 109.0 111.0 106.0 111.0 110.0 110.0 100.0 109.0 109.0 109.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:152.00 stddev:19.72 (13.0%) stddev-sans-first:20.58 08:27:57 INFO - PROCESS | 7527 | Values: 156.0 125.0 155.0 182.0 127.0 148.0 149.0 124.0 166.0 128.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:2.50 (1.6%) stddev-sans-first:1.17 08:27:57 INFO - PROCESS | 7527 | Values: 168.0 161.0 160.0 162.0 161.0 159.0 160.0 161.0 163.0 161.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#3] audio-fft Cycles:10 Average:85.10 Median:78.00 stddev:15.15 (19.4%) stddev-sans-first:15.31 08:27:57 INFO - PROCESS | 7527 | Values: 72.0 75.0 97.0 97.0 81.0 72.0 72.0 114.0 98.0 73.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:95.50 stddev:24.34 (25.5%) stddev-sans-first:25.26 08:27:57 INFO - PROCESS | 7527 | Values: 96.0 96.0 158.0 95.0 95.0 96.0 139.0 95.0 96.0 137.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:27:57 INFO - PROCESS | 7527 | Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 08:27:57 INFO - PROCESS | 7527 | Values: 145.0 147.0 145.0 147.0 145.0 146.0 146.0 146.0 145.0 146.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:27:57 INFO - PROCESS | 7527 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:3.63 (6.5%) stddev-sans-first:3.81 08:27:57 INFO - PROCESS | 7527 | Values: 58.0 56.0 56.0 55.0 55.0 55.0 57.0 66.0 53.0 54.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 08:27:57 INFO - PROCESS | 7527 | Values: 67.0 67.0 67.0 67.0 68.0 68.0 67.0 66.0 67.0 68.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:3.07 (3.7%) stddev-sans-first:3.18 08:27:57 INFO - PROCESS | 7527 | Values: 81.0 80.0 81.0 89.0 82.0 81.0 82.0 82.0 83.0 88.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:118.50 stddev:5.56 (4.7%) stddev-sans-first:5.87 08:27:57 INFO - PROCESS | 7527 | Values: 116.0 129.0 114.0 122.0 111.0 116.0 121.0 112.0 121.0 114.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:142.00 stddev:4.64 (3.3%) stddev-sans-first:4.92 08:27:57 INFO - PROCESS | 7527 | Values: 142.0 141.0 145.0 141.0 152.0 133.0 143.0 141.0 142.0 142.0 08:27:57 INFO - PROCESS | 7527 | 08:27:57 INFO - PROCESS | 7527 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:2.87 (4.3%) stddev-sans-first:3.03 08:27:57 INFO - PROCESS | 7527 | Values: 67.0 67.0 75.0 68.0 65.0 67.0 65.0 69.0 66.0 68.0 08:27:57 INFO - PROCESS | 7527 | -------- Summary: end -------- 08:27:57 INFO - PROCESS | 7527 | 08:27:58 INFO - TEST-INFO | 7527: exit 0 08:27:58 INFO - TEST-OK | kraken | took 58724ms 08:27:58 INFO - TEST-START | v8_7 08:27:58 INFO - operating with platform_type : linux_ 08:27:58 INFO - Initialising browser for v8_7 test... 08:27:58 INFO - TEST-INFO | started process 7774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA7xkXt/profile http://localhost:52107/getInfo.html) 08:28:02 INFO - PROCESS | 7774 | __metrics Screen width/height:1600/1200 08:28:02 INFO - PROCESS | 7774 | colorDepth:24 08:28:02 INFO - PROCESS | 7774 | Browser inner width/height: 1024/697 08:28:02 INFO - PROCESS | 7774 | __metrics 08:28:02 INFO - PROCESS | 7774 | 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:28:02 INFO - PROCESS | 7774 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:03 INFO - TEST-INFO | 7774: exit 0 08:28:03 INFO - Browser initialized. 08:28:03 INFO - Running cycle 1/1 for v8_7 test... 08:28:03 INFO - TEST-INFO | started process 7856 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA7xkXt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:15 INFO - PROCESS | 7856 | RSS: Main: 149389312 08:28:15 INFO - PROCESS | 7856 | 08:28:37 INFO - PROCESS | 7856 | Cycle 1(1): loaded http://localhost:52107/tests/v8_7/run.html (next: http://localhost:52107/tests/v8_7/run.html) 08:28:38 INFO - PROCESS | 7856 | RSS: Main: 508366848 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | __start_tp_report 08:28:38 INFO - PROCESS | 7856 | _x_x_mozilla_page_load 08:28:38 INFO - PROCESS | 7856 | _x_x_mozilla_page_load_details 08:28:38 INFO - PROCESS | 7856 | |i|pagename|runs| 08:28:38 INFO - PROCESS | 7856 | |0;Richards;166.9727834362999 08:28:38 INFO - PROCESS | 7856 | |1;DeltaBlue;187.65246762994934 08:28:38 INFO - PROCESS | 7856 | |2;Encrypt;279.6420581655481 08:28:38 INFO - PROCESS | 7856 | |3;Decrypt;5240.837696335078 08:28:38 INFO - PROCESS | 7856 | |4;RayTrace;1112.3470522803113 08:28:38 INFO - PROCESS | 7856 | |5;Earley;788.1889763779527 08:28:38 INFO - PROCESS | 7856 | |6;Boyer;12358.024691358025 08:28:38 INFO - PROCESS | 7856 | |7;RegExp;42458.333333333336 08:28:38 INFO - PROCESS | 7856 | |8;Splay;567.7200902934537 08:28:38 INFO - PROCESS | 7856 | |9;NavierStokes;4854.368932038835 08:28:38 INFO - PROCESS | 7856 | __end_tp_report 08:28:38 INFO - PROCESS | 7856 | __startTimestamp1452702518051__endTimestamp 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | ------- Summary: start ------- 08:28:38 INFO - PROCESS | 7856 | Number of tests: 10 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 167.0 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#1] DeltaBlue Cycles:1 Average:187.65 Median:187.65 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 187.7 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 279.6 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 5240.8 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 1112.3 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#5] Earley Cycles:1 Average:788.19 Median:788.19 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 788.2 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 12358.0 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#7] RegExp Cycles:1 Average:42458.33 Median:42458.33 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 42458.3 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#8] Splay Cycles:1 Average:567.72 Median:567.72 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 567.7 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - PROCESS | 7856 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 08:28:38 INFO - PROCESS | 7856 | Values: 4854.4 08:28:38 INFO - PROCESS | 7856 | -------- Summary: end -------- 08:28:38 INFO - PROCESS | 7856 | 08:28:38 INFO - TEST-INFO | 7856: exit 0 08:28:38 INFO - TEST-OK | v8_7 | took 40305ms 08:28:38 INFO - SUITE-END | took 1211s 08:28:39 INFO - Completed test suite (00:20:11) 08:28:39 INFO - Working with test: dromaeo_css 08:28:39 INFO - Generating results file: dromaeo_css 08:28:39 INFO - Working with test: kraken 08:28:39 INFO - Generating results file: kraken 08:28:39 INFO - javascript benchmark 08:28:39 INFO - Working with test: v8_7 08:28:39 INFO - Generating results file: v8_7 08:28:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:28:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:28:39 INFO - process_Request line: dromaeo_css 6580.92 graph.html#tests=[[72,64,35]] 08:28:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:28:39 INFO - process_Request line: kraken 1496.10 graph.html#tests=[[232,64,35]] 08:28:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:28:39 INFO - process_Request line: v8_7 20120.03 graph.html#tests=[[230,64,35]] 08:28:39 INFO - RETURN: dromaeo_css: 6580.92 08:28:39 INFO - RETURN: kraken: 1496.10 08:28:39 INFO - RETURN: v8_7: 20120.03 08:28:39 INFO - javascript benchmark 08:28:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3166.1134882232977, 3190.978886756239, 3237.28779668473, 3243.5459035735016, 3266.0528446750436, 5082.822101226458, 5184.248283998822, 5196.506331898473, 5197.246399272103, 5248.39643441004, 5109.080365534202, 5168.2764412982215, 5178.067947769409, 5198.168293073109, 5209.453007434222, 4659.440867095945, 4685.1800934836265, 4712.787924543387, 4769.737664428455, 4794.568488836004, 4701.553352431513, 4767.690100143497, 4843.878903027435, 4850.054239423313, 4888.242322440027, 4616.076784643051, 4641.396618439615, 4725.0, 4773.379460670126, 4789.473157952622, 4734.124187025412, 4760.23836186212, 4768.976155119202, 4773.809047638125, 4779.091972525209, 4725.125851717443, 4730.692504987165, 4741.57325840676, 4743.217369134089, 4767.737774422405, 4884.19410797218, 4965.329680493123, 5033.496650334974, 5051.318072060299, 5074.112030394703, 5570.637908535932, 5577.8605534861545, 5582.441755824426, 5591.161325801162, 5593.748281327309, 5600.439956004367, 5605.0, 5628.774849006035, 5630.380658127603, 5630.8029218977135, 5138.691678499302, 5163.509466600704, 5201.713905735183, 5238.816641417532, 5249.868753281198, 5732.7706891723865, 5734.369219385864, 5734.39788822176, 5739.253896993364, 5742.626729262584, 5511.53151982078, 5520.337559492807, 5527.170924361378, 5531.751071201806, 5534.75093620788, 5480.534154596904, 5545.417731138253, 5566.526845218202, 5599.384067752544, 5647.830565083054, 5450.236966824647, 5458.6724796512335, 5464.207689884945, 5467.152591348347, 5467.343918729698, 5428.4842939920645, 5447.101228297287, 5447.264619276426, 5449.073657478159, 5501.889962200734, 4303.827846886152, 4322.0, 4388.385626012361, 4390.7585082820115, 4399.274119770202, 3845.8269377878064, 3859.671927886161, 3865.053061999828, 3898.532176138825, 3929.5677475477673, 5179.352580927384, 5191.922121168185, 5207.531322181022, 5218.0, 5228.320318358589, 5486.149646804752, 5508.03609368359, 5556.555475561945, 5570.164475328733, 5594.272744543265, 5163.535281824654, 5184.196449550326, 5188.481151884781, 5192.584593232532, 5193.039287731782, 4763.04739052191, 4770.522947705202, 4772.570468657837, 4774.522547745267, 4795.448523419851, 5695.629784064023, 5709.600327977085, 5814.563907706939, 5829.5336373090895, 5878.088896221093, 5472.808451704331, 5473.890522189454, 5477.123660214346, 5478.397376288525, 5481.232627432242, 5635.0702134147405, 5670.347909990404, 5675.0, 5688.544916406595, 5700.714964251853, 5476.315460567429, 5490.286262785812, 5520.944790552043, 5527.53015993645, 5570.91643625354, 5554.194641776839, 5572.136318870582, 5604.551635869039, 5613.158026296088, 5615.971920140373, 5404.432534583812, 5487.506124448819, 5493.7802487900035, 5504.669719816824, 5528.253685752372, 5399.649022813504, 5461.290032295935, 5462.726863656881, 5467.4532546745, 5513.365962914316, 5360.0619891518045, 5390.784368625211, 5400.513953744182, 5401.216823560483, 5453.127499600045, 5313.123334649739, 5346.97326513365, 5402.567794576503, 5485.61600687948, 5512.035393806148, 5340.439253878287, 5382.784688612412, 5406.24312596229, 5411.918821217763, 5419.918701219563], "unit": "score", "name": "dojo.html", "value": 5136.495628227757}, {"lowerIsBetter": false, "replicates": [518.3080587415802, 531.1819797511832, 536.7987004873172, 543.2693027877503, 592.7006861534927, 27649.861750691245, 27960.0, 27960.58059129112, 27989.440211195764, 27998.0, 28060.438791224162, 28405.289867753316, 35680.10799730008, 36519.26961460769, 36560.634393656124, 8435.915640843605, 8537.402381833273, 8597.871031934526, 8598.0, 8601.397902146853, 8340.207680270365, 8469.534175620338, 8475.872861907046, 8482.872756908651, 8485.151484851496, 8478.152184781535, 8522.531260780655, 8541.871871921927, 8562.914370856273, 8563.186497282748, 8614.267787238061, 8669.869951950726, 8691.652333906635, 8711.651533938666, 8713.607887645008, 8487.193716596914, 8593.656253749843, 8618.78453038679, 8625.956870215608, 8628.827423451496, 35926.46110308347, 36016.45975310372, 36210.09474763126, 36226.275474490365, 36261.45607815885, 3189.4259033373983, 3260.3805276997296, 3276.770626056177, 3591.102224443889, 3756.624337566249, 28912.710872891214, 29327.12018639444, 29525.114246572637, 29567.40865182684, 29709.40581188386, 3806.71449641278, 3809.733318667694, 3829.812698222714, 3834.482344883433, 3922.7057970652313, 266933.0, 267417.0, 268337.0, 269064.0, 269149.0, 48934.510654893, 54426.18360724593, 54603.453965459834, 54653.72673136609, 54862.45137548653, 44771.328430073576, 44951.550484494735, 44958.0, 45001.0, 60186.39813601896, 13406.061575689608, 13509.256990865597, 13575.864241357658, 13589.524366647318, 13602.387892544859, 10255.230857685703, 10322.432266225429, 10330.173586113093, 10334.586616535405, 10335.689929302132, 16223.91888040576, 16804.32782688703, 18443.538911527317, 18955.431337059912, 19078.523036924187, 7140.072570246278, 7292.8176795579475, 7393.186749457555, 7459.962700186573, 7465.141508726458, 964.7491652170486, 1014.3895992713136, 1057.3867157048894, 1061.9097376723066, 1066.424130969268, 27687.584686229722, 28429.15708429182, 28605.0, 28892.85553572219, 28924.855375722986, 993.8558908958161, 1030.0266248395344, 1033.679559336608, 1083.285031878956, 1105.4804242006244, 13404.664883377993, 13433.865661343458, 13468.5286014989, 13620.318984050957, 13660.043796934118, 341358.0, 341400.0, 343416.0, 343834.0, 344084.0, 48576.0, 48865.511344886094, 48878.26682599764, 48911.51088489141, 49100.263496047584, 1288.0854593238905, 1293.4438191577713, 1317.960461186166, 1322.3718733601654, 1324.72843067171, 23606.0, 25391.36521586975, 26957.865210673823, 27053.59419608668, 27271.318217044733, 45944.54055459402, 47820.521794781605, 47825.521744782105, 47844.521554784005, 47911.5208847921, 203517.0, 203792.0, 204284.0, 204710.0, 205169.0, 27248.318792030357, 27869.86065069743, 30249.546256805726, 30388.544171837, 30594.235144121576, 41209.38185927273, 41502.0, 41512.79243603763, 41522.169556608096, 42096.947576310835, 29579.40841183207, 29728.85135574308, 32542.186445339055, 32647.673523265414, 33788.66211337855, 28226.85886570554, 33993.8102166423, 34023.4896476558, 34049.31901362009, 34185.658143418244, 29770.70229297679, 31643.683563164075, 31666.0, 31672.366552668358, 31688.04935851928, 25390.866179369674, 28794.0, 31135.53296700506, 33049.669503305624, 34685.306293874484, 23885.761142388354, 23980.341035092282, 24036.63945040861, 24086.39784005414, 24163.758362416855], "unit": "score", "name": "ext.html", "value": 17158.204224177753}, {"lowerIsBetter": false, "replicates": [359.1524003352089, 363.9017465284372, 364.5352175975631, 365.62706039839367, 365.77504834526775, 13637.795433068488, 13907.165570065803, 15601.297941592627, 16213.270402831871, 17102.0, 14698.63253418665, 15393.769093463607, 15792.605184870385, 15817.683646327067, 16593.83406165938, 5223.112070947948, 5410.242566040757, 5414.675119492843, 5421.647592906468, 5422.810201642943, 3932.2135572885395, 4060.0255938574824, 5221.451747566508, 5349.8127565535215, 5543.889122217553, 5663.4336566343445, 5694.544436445074, 5716.971415142939, 5717.828465146053, 5729.598928075036, 5108.412532558747, 5285.577153827685, 5294.311739473882, 5315.176147697113, 5317.335333083345, 4826.7827947742435, 5008.54923056923, 5013.323201367805, 5019.749012549358, 5099.33708617881, 12028.398580070962, 12324.445399957023, 12605.180663256859, 12616.558420455332, 12631.178973366701, 2009.5076706206926, 2053.301877361704, 2094.2984100326407, 2143.7749036351115, 2157.061678170001, 11826.662203146761, 11845.111616628787, 12261.754764904741, 12681.112322137455, 13042.86957130426, 1769.5664562182349, 1808.728690696393, 1817.3548390321378, 1868.953276168093, 1876.2213681322235, 55426.44573554293, 55890.0, 56595.43404565943, 57363.71318143424, 58162.836743264896, 9716.854247186298, 10129.290949633601, 10145.746356341151, 10150.390976541432, 10251.948740256252, 13366.730160634725, 13576.796348054788, 13585.59243222705, 13598.660033499242, 13626.454941802414, 7239.855202895913, 7253.455990800711, 7253.782386528413, 7309.122905251404, 7376.262373762581, 6853.623050732158, 6890.276520965327, 6927.653617319113, 6955.061066756024, 6968.58188508681, 4406.933895991563, 4483.3723278741, 4499.055198408371, 4520.344550040291, 4521.0279789845345, 1706.906120163378, 1767.2489192093567, 1768.7170052791748, 1791.8208179182238, 1812.1301775148004, 447.78953891670864, 449.9662525310549, 452.36894532127496, 461.28040257198876, 926.7961048569304, 10442.2168337375, 10457.790844183073, 10517.737056573647, 10524.631637892637, 10739.35563866155, 452.9139463501924, 467.0518846741121, 478.6840685147855, 480.04710649360993, 493.54158461745453, 5745.569082318842, 5840.386759390203, 5861.501772349313, 5980.611260268069, 5997.0, 358208.0, 540912.0, 548306.1016339032, 557106.0, 558307.0, 54995.0, 61950.0, 62166.0675089874, 64777.0, 71513.6424317875, 474.3374472473957, 483.014650113771, 483.78713366118797, 484.2059023201881, 484.5566306829212, 9867.273227185071, 10193.133583645176, 11146.721331966766, 13687.31563421805, 13906.58280251594, 29959.550606740482, 30161.245968850955, 31538.211544711565, 32266.516002259516, 33695.3260934775, 39953.20093598054, 40617.39073913835, 40663.18673626452, 42117.0, 42210.36684449674, 6854.868946623751, 7136.714531418893, 7177.282271772781, 7229.385502232369, 7505.249475052669, 10303.896961030594, 10813.729656758644, 11416.429178540873, 11536.480858361227, 11596.942015290208, 9458.716238512856, 9902.405855648683, 10020.749481263027, 10109.545070471699, 10282.07461328484, 9678.95160524193, 9902.801943961225, 10109.49452527356, 10174.389536627827, 10438.269321147447, 8660.350473714623, 9787.021297870157, 9827.55775990068, 10032.69901902944, 10092.091711745978, 7137.82155446118, 7262.9273707262255, 7290.635468226674, 7347.669354878936, 7390.150132734804, 8438.071812100541, 8950.68672596456, 9831.85252221203, 9893.950530247303, 10146.746331341776], "unit": "score", "name": "jquery.html", "value": 7311.053920117501}, {"lowerIsBetter": false, "replicates": [1294.2816736711134, 1453.048253394027, 1469.8750606198469, 1606.3574570171936, 1771.840534351908, 6822.488313376498, 7308.196098429168, 7420.814479637998, 7422.851542969137, 7432.554046757198, 7331.156916954552, 7508.511946723459, 7513.135989361212, 7519.962400187991, 7522.134954480236, 1939.9127039283267, 1941.417574727583, 1949.0449679656938, 2286.702728645274, 2340.32130682102, 2027.6248893954667, 2288.8969996350206, 2340.3681006128336, 2344.660024296476, 2345.061975209913, 2185.25701261571, 2197.165077270643, 2203.5152266501423, 2208.7791220877943, 2256.277991042867, 2267.943301417461, 2271.0915633746467, 2275.419767959176, 2283.041122728458, 2283.246528645543, 2274.3972847195505, 2306.042992158252, 2306.8385213035094, 2308.3882771065682, 2323.1984965187153, 7601.201873803282, 7668.539887606761, 7671.693132274702, 7672.0, 7674.808129796744, 4741.502142275046, 4810.470848206694, 4847.587955023827, 4850.272459131159, 4854.17479028566, 3007.6090108286003, 3141.0419821954297, 3154.779165458419, 3162.4940009598586, 3178.96821031789, 975.0493269062678, 997.6607953295915, 1007.7027276953243, 1008.9747756306151, 1030.258214085857, 10416.375017498975, 10584.947075264652, 10594.523246453928, 10599.89400105989, 10600.0, 4389.736615803062, 4421.42521472213, 4455.04216593434, 4479.7984090716, 4484.372187893698, 9163.679271225476, 9216.63133474667, 9222.262219022463, 9222.40054396462, 9225.861612075823, 4839.395075615548, 4848.0, 4879.56083952446, 4886.486918873538, 4889.633277504201, 4408.6913916026215, 4412.514623391425, 4417.690761646654, 4420.447444069491, 4422.226110430662, 3393.813340266309, 3554.360215161296, 3602.4056030755155, 3648.6533779290926, 3649.251903359805, 1116.5812820192427, 1175.371176420611, 1202.6692659518528, 1220.8657047724744, 1222.034592671797, 1257.9245245285313, 1280.481405030964, 1301.3103055380664, 1304.804279358104, 1306.1510018487868, 6796.388325050671, 6960.060391847036, 6972.0, 6975.162980442278, 6976.476764242702, 1080.2600218850114, 1085.2132204152085, 1104.2987702808775, 1112.6828853776635, 1115.587232723881, 5548.167774833807, 5663.9716801415725, 5669.574781891375, 5736.282964629421, 5764.279465066867, 8998.59506322217, 9091.27269818413, 9445.291603129794, 9451.905480945103, 9456.952715236379, 9222.95388523053, 9291.58187881547, 9308.255339572817, 9342.346035777566, 9352.111549402796, 6816.556923799937, 6944.992976018449, 7003.6848341823725, 7125.714971401086, 7310.378617817439, 7061.823454413475, 7185.604791736505, 7187.6765545551625, 7194.676239569128, 7195.244499327705, 7966.402519811153, 8054.798630034296, 8072.878906816285, 8072.919270807217, 8191.262786349257, 8311.293540049164, 8474.152584741476, 8475.533845638549, 8654.956725216334, 8670.306375490072, 6753.223379311442, 6762.932370676427, 6779.35596118368, 6783.89824152648, 6792.0, 6500.674966251763, 6662.966685166543, 7288.672009759467, 7401.777946661608, 7426.18311985692, 6765.357291057342, 6811.5231933766145, 6885.070515480546, 6996.545224560387, 7002.0547226125855, 6663.600183988976, 6736.797896063126, 6739.224989126314, 6797.694103765243, 6893.20728116253, 6702.83242918931, 6748.7300507979135, 6761.594304341756, 6762.019507171531, 6764.492663050192, 6285.685715714105, 6317.30509643948, 6322.0, 6361.2048493938255, 6362.491000719839, 6034.24571928509, 6193.690315484298, 6215.564910456405, 6309.0, 6310.936890631035], "unit": "score", "name": "mootools.html", "value": 4442.546712985502}, {"lowerIsBetter": false, "replicates": [341.3190684584255, 348.78898266548737, 349.882789265596, 352.89589571076544, 353.0238889470613, 5734.655920644765, 5761.884762304751, 5767.4809267166, 5770.884582308351, 5775.451332123452, 5488.4785945335125, 5556.277683901088, 5621.690807005613, 5683.460071293221, 5707.115397113444, 4407.2948328267485, 4438.267685831842, 4441.067375851075, 4451.999999999984, 4460.643148548124, 4348.152110338485, 4451.465824101097, 4453.576910193527, 4455.84404545841, 4465.5311192324825, 4367.912641747163, 4401.581849724287, 4471.575200355961, 4491.348754430605, 4501.729896206221, 4446.888827779299, 4478.350639157336, 4483.865484035484, 4489.4612646482465, 4491.348754430605, 3984.242993831163, 3988.062805240766, 3989.7007724420782, 3991.501062367204, 3994.2810294147334, 5481.342238931314, 5565.41563135873, 5575.609707320489, 5580.581456390787, 5589.217509548666, 5218.791248350061, 5231.136862417697, 5232.7122008289525, 5234.42421333653, 5236.057509648262, 6111.083337499366, 6119.143319935168, 6119.357467465897, 6120.234970628671, 6121.051237058218, 4424.491183513905, 4425.09285596452, 4428.446444194476, 4430.246858034142, 4443.155800397946, 6244.656543890084, 6401.711922963478, 6406.775762848324, 6456.192975878015, 6477.190351206099, 4524.660650451229, 4529.048899731028, 4531.365608814768, 4535.501094879626, 4550.067236216568, 4598.172328980816, 4600.194965880957, 4600.631949444037, 4600.7929643166135, 4603.631709463235, 5219.347581552306, 5219.608529360313, 5220.660657057279, 5222.2427747976335, 5228.2941802856885, 6038.33578306386, 6139.57023008394, 6155.938440615626, 6162.044883043135, 6167.629942203482, 1599.3682495414246, 1621.8621417179672, 1622.5456872075838, 1622.9188540573161, 1623.6914986152594, 1102.7022703869911, 1114.3202646385698, 1116.3023110555903, 1118.0440723181562, 1136.4545018391218, 5813.069908814569, 5819.6508209507565, 5821.097729851795, 5827.854303642358, 5827.9509688255675, 6238.313785483593, 6247.0, 6294.874102517924, 6298.181236439325, 6309.337519560472, 5667.773289068474, 5671.914921276184, 5783.797567085216, 5794.971025144847, 5846.386129456431, 3380.712639425627, 3394.3890099782275, 3402.1834759657504, 3402.8468718907707, 3406.1144102533026, 6457.418832305115, 6494.447971922439, 6507.479401647857, 6513.153290072355, 6653.334666533308, 6387.520935929824, 6499.2200935887995, 6500.187476565429, 6532.5753826001155, 6541.574797638234, 6582.934170658328, 6618.437432818168, 6661.16735408074, 6665.566738162101, 6666.466682665375, 6325.77859774924, 6334.904976425265, 6340.841478963062, 6341.841453963688, 6343.207099112611, 6122.142899994094, 6256.655883926245, 6260.248770147429, 6269.811905642838, 6273.498120150468, 6580.078788969452, 6586.407223349922, 6587.374199451045, 6589.703463344257, 6592.17597800275, 4483.14820184164, 4486.730796152241, 4491.48347939978, 4497.662675299301, 4501.482329532146, 6247.625142491465, 6301.527385446018, 6359.3640635936035, 6364.554481186273, 6365.52258580599, 6194.101855231056, 6201.472874805692, 6203.472704820141, 6210.347913469021, 6210.503159747119, 6201.255849298113, 6201.286852012076, 6210.441060304594, 6212.658303793335, 6218.347073557211, 5968.253968253968, 6054.061620448838, 6072.14989901423, 6079.908801367895, 6092.817215483543, 6222.968885155546, 6228.4705800007505, 6229.314775374614, 6233.532485063548, 6237.095621135, 6045.21412216409, 6079.148919151411, 6082.695865206811, 6087.66517841523, 6089.360617135137], "unit": "score", "name": "prototype.html", "value": 4686.615171161181}, {"lowerIsBetter": false, "replicates": [755.2560727683231, 755.4862693368509, 804.981698151838, 818.4679958027277, 841.7138173021171, 12590.307533085677, 12754.0, 12801.871981280185, 12835.807462888053, 12864.09951303409, 11655.242409243414, 11876.881231187686, 11938.880611193885, 11967.281963082221, 11994.100442466806, 814.0963530481176, 820.7004443378154, 821.6918655504186, 821.765796747927, 822.0587427395628, 682.0485422835142, 686.2177118085361, 809.9271065604095, 821.2280456370992, 823.8352329534088, 848.9235968762811, 854.8375808596347, 856.3021137772695, 857.2670366836359, 857.7984173719202, 705.5061456980084, 711.249631638621, 854.7136709202425, 856.7386946981168, 856.9185927336924, 524.0750076115659, 524.9816256431045, 524.9842504724826, 607.9179310793074, 636.7134789344814, 12106.092043096714, 12113.93943030288, 12118.757624847542, 12118.939405302917, 12131.150819442642, 11630.825537616942, 12133.817992730115, 12183.238302741975, 12284.754304913851, 12287.077900033937, 9549.47477888716, 9655.758606034906, 9698.9515052425, 9910.801783964353, 9983.950080249553, 3558.1460449491938, 3628.0, 3636.5272514572935, 3706.2031663192543, 3708.888733337977, 46346.0, 46512.53487465116, 46530.76734616339, 46693.76653116713, 46720.0, 8700.390972631854, 8909.1536304051, 9120.8631870522, 9179.082091790768, 9227.44635321883, 16403.91798041002, 16511.669766604842, 16546.91726541384, 16558.503244902673, 16580.336786528405, 6940.757073502504, 7250.456215783732, 7364.22675619063, 7368.410527157815, 7420.369268612229, 4164.83340666376, 4243.42713733642, 4299.226139294957, 4317.676174286941, 4325.9134817303475, 2921.956170657442, 2955.6305461817274, 2995.05655718448, 3016.7888247822443, 3026.3644634626535, 603.7283222549783, 606.5693357715983, 611.5321778839192, 611.5566214494545, 625.2340882419091, 551.6000899348021, 620.3052581109187, 623.7442648514087, 623.9766782476742, 657.8486948001986, 7562.773116806505, 7926.762197134095, 8079.232472915063, 8131.416429044223, 8200.548969806718, 572.1646396261422, 625.5371025441141, 643.6363454648109, 671.3689132215702, 679.3206793206793, 3707.4994875691978, 3770.698344132463, 4011.1777085697363, 4215.536291007987, 4243.172581346607, 54441.0, 55961.440385596434, 56042.71978640162, 56073.0, 56436.435635643116, 48552.5144748548, 50123.74938125286, 50579.0, 50734.238986415236, 51271.48728512742, 42358.57641423608, 42867.35698964518, 43227.35158972618, 45931.77034114808, 46057.30914036292, 7736.8242501646255, 7980.201979801974, 8084.595770211348, 8188.590570471333, 8246.711365102192, 33196.1700957478, 33347.666523334454, 34133.31733365269, 34697.0, 34967.0, 39551.2089758209, 39599.40600890931, 43669.0, 43723.34414983714, 44130.0, 10293.639722609672, 10295.742606434898, 10414.895851041696, 10939.124870010539, 11445.599404020819, 11033.889661103607, 11205.887941120485, 11245.212835101463, 11310.321380717183, 11369.204155709022, 10511.632092876713, 10548.419836909045, 11042.061424778662, 11203.103751699682, 11261.21171517986, 10877.564897404016, 10887.129029677448, 10924.0, 10930.180236482454, 11292.573981016283, 10430.26988110825, 10655.14758819277, 10736.731581710208, 11048.834267485834, 11083.279586826831, 8826.735197944072, 9092.818143637223, 9311.301652375963, 9325.720228393158, 9343.906560934303, 8836.293096552388, 8944.910550894669, 8955.507447090473, 9799.11807937289, 10010.299279050396], "unit": "score", "name": "yui.html", "value": 6054.4457258663515}], "name": "dromaeo_css", "value": 6580.920542530584}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 111.0, 110.0, 110.0, 100.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [156.0, 125.0, 155.0, 182.0, 127.0, 148.0, 149.0, 124.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [168.0, 161.0, 160.0, 162.0, 161.0, 159.0, 160.0, 161.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 97.0, 97.0, 81.0, 72.0, 72.0, 114.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 158.0, 95.0, 95.0, 96.0, 139.0, 95.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 55.0, 55.0, 55.0, 57.0, 66.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 66.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 81.0, 89.0, 82.0, 81.0, 82.0, 82.0, 83.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [116.0, 129.0, 114.0, 122.0, 111.0, 116.0, 121.0, 112.0, 121.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.6}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 145.0, 141.0, 152.0, 133.0, 143.0, 141.0, 142.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 75.0, 68.0, 65.0, 67.0, 65.0, 69.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1496.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [187.65246762994934], "unit": "score", "name": "DeltaBlue", "value": 352.34282199999996}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [788.1889763779527], "unit": "score", "name": "Earley", "value": 845.5624475524476}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [42458.333333333336], "unit": "score", "name": "RegExp", "value": 21.455976447497545}, {"lowerIsBetter": false, "replicates": [567.7200902934537], "unit": "score", "name": "Splay", "value": 143.54080715705769}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20120.031295208133}]} 08:28:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20120.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6580.92"}}} 08:28:39 INFO - Return code: 0 08:28:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:28:39 INFO - # TBPL SUCCESS # 08:28:39 INFO - Running post-action listener: _resource_record_post_action 08:28:39 INFO - Running post-run listener: _resource_record_post_run 08:28:40 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542240768; Read time: 12; Write time: 464156 08:28:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 175382528; Read time: 0; Write time: 222856 08:28:40 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 302759936; Read time: 0; Write time: 172924 08:28:40 INFO - Running post-run listener: _upload_blobber_files 08:28:40 INFO - Blob upload gear active. 08:28:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:28:40 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:28:40 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:28:40 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:28:40 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:28:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:41 INFO - (blobuploader) - INFO - Done attempting. 08:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:42 INFO - (blobuploader) - INFO - Done attempting. 08:28:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:42 INFO - Return code: 0 08:28:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:28:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3df30ab62b608c62400d1f449dc8b183cd27212977569df611aa8e96e7e1ec159e6a026b66f7fc4ad92fcbab51339c96cb246da562bf3de49112aff386a2f053", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c269f9f8283d0ab243caa94e8a1dbb90dd23ccc7995cfaf6d7511b31b1f68ce1d5e813d566980ab64819caf05c5e476b695d187e349216a91961beff74add54a"} 08:28:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:28:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:28:42 INFO - Contents: 08:28:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3df30ab62b608c62400d1f449dc8b183cd27212977569df611aa8e96e7e1ec159e6a026b66f7fc4ad92fcbab51339c96cb246da562bf3de49112aff386a2f053", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c269f9f8283d0ab243caa94e8a1dbb90dd23ccc7995cfaf6d7511b31b1f68ce1d5e813d566980ab64819caf05c5e476b695d187e349216a91961beff74add54a"} 08:28:42 INFO - Copying logs to upload dir... 08:28:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.137417 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-13 08:28:42.475339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 08:28:42.478526) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3df30ab62b608c62400d1f449dc8b183cd27212977569df611aa8e96e7e1ec159e6a026b66f7fc4ad92fcbab51339c96cb246da562bf3de49112aff386a2f053", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c269f9f8283d0ab243caa94e8a1dbb90dd23ccc7995cfaf6d7511b31b1f68ce1d5e813d566980ab64819caf05c5e476b695d187e349216a91961beff74add54a"} build_url:https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/PsMz5Ak1QqO2ZzwMYiyEQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3df30ab62b608c62400d1f449dc8b183cd27212977569df611aa8e96e7e1ec159e6a026b66f7fc4ad92fcbab51339c96cb246da562bf3de49112aff386a2f053", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c269f9f8283d0ab243caa94e8a1dbb90dd23ccc7995cfaf6d7511b31b1f68ce1d5e813d566980ab64819caf05c5e476b695d187e349216a91961beff74add54a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 08:28:42.503264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 08:28:42.503577) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1452700240.860262-1451789582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 08:28:42.586425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 08:28:42.586752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 08:28:42.587098) ========= ========= Total master_lag: 0.23 =========